builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0005 starttime: 1492603068.47 results: success (0) buildid: 20170419030223 builduid: 15059296d08342d4b73e158562765efa revision: c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:48.471479) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:48.471946) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:48.472236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:49.457548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 04:57:49.457935) ========= 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.ypHf3kmtML/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.zk24HIRC9L/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-19 04:57:49-- 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% 18.8M=0.001s 2017-04-19 04:57:50 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.138398 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 04:57:50.871556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:50.871882) ========= 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.ypHf3kmtML/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.zk24HIRC9L/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.027594 ========= master_lag: 0.54 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:51.442916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 04:57:51.443512) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e --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 c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ypHf3kmtML/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.zk24HIRC9L/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-19 04:57:51,656 truncating revision to first 12 chars 2017-04-19 04:57:51,656 Setting DEBUG logging. 2017-04-19 04:57:51,656 attempt 1/10 2017-04-19 04:57:51,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c0ea5ed7f91a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-19 04:57:52,889 unpacking tar archive at: mozilla-central-c0ea5ed7f91a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.506386 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 04:57:53.189324) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:53.189639) ========= script_repo_revision: c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:53.190010) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:53.190281) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:53.961466) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2017-04-19 04:57:53.961884) ========= /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.ypHf3kmtML/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.zk24HIRC9L/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:57:54 INFO - MultiFileLogger online at 20170419 04:57:54 in /builds/slave/test 04:57:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:57:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:57:54 INFO - {'append_to_log': False, 04:57:54 INFO - 'base_work_dir': '/builds/slave/test', 04:57:54 INFO - 'blob_upload_branch': 'Firefox', 04:57:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:57:54 INFO - 'branch': 'Firefox', 04:57:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:54 INFO - 'config_files': ('talos/mac_config.py',), 04:57:54 INFO - 'default_actions': ('clobber', 04:57:54 INFO - 'read-buildbot-config', 04:57:54 INFO - 'download-and-extract', 04:57:54 INFO - 'populate-webroot', 04:57:54 INFO - 'create-virtualenv', 04:57:54 INFO - 'install', 04:57:54 INFO - 'run-tests'), 04:57:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:54 INFO - 'download_minidump_stackwalk': True, 04:57:54 INFO - 'download_symbols': 'ondemand', 04:57:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:54 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:54 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:54 INFO - 'gecko_profile': False, 04:57:54 INFO - 'gecko_profile_interval': 0, 04:57:54 INFO - 'installer_path': 'installer.exe', 04:57:54 INFO - 'log_level': 'info', 04:57:54 INFO - 'log_name': 'talos', 04:57:54 INFO - 'log_to_console': True, 04:57:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:57:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:57:54 INFO - 'opt_config_files': (), 04:57:54 INFO - 'pip_index': False, 04:57:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:57:54 INFO - 'cmd': ('bash', 04:57:54 INFO - '-c', 04:57:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:57:54 INFO - 'enabled': True, 04:57:54 INFO - 'halt_on_failure': False, 04:57:54 INFO - 'name': 'check_screen_resolution'},), 04:57:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:57:54 INFO - 'cmd': ('bash', 04:57:54 INFO - '-c', 04:57:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:57:54 INFO - 'enabled': True, 04:57:54 INFO - 'halt_on_failure': False, 04:57:54 INFO - 'name': 'check_screen_resolution'},), 04:57:54 INFO - 'run_cmd_checks_enabled': True, 04:57:54 INFO - 'suite': 'dromaeojs', 04:57:54 INFO - 'system_bits': '32', 04:57:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:54 INFO - 'title': 't-yosemite-r7-0005', 04:57:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:54 INFO - 'use_talos_json': True, 04:57:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:57:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:54 INFO - 'work_dir': 'build'} 04:57:54 INFO - [mozharness: 2017-04-19 11:57:54.263894Z] Running clobber step. 04:57:54 INFO - Running pre-action listener: _resource_record_pre_action 04:57:54 INFO - Running main action method: clobber 04:57:54 INFO - rmtree: /builds/slave/test/build 04:57:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:57:56 INFO - Running post-action listener: _resource_record_post_action 04:57:56 INFO - [mozharness: 2017-04-19 11:57:56.890383Z] Finished clobber step (success) 04:57:56 INFO - [mozharness: 2017-04-19 11:57:56.890534Z] Running read-buildbot-config step. 04:57:56 INFO - Running pre-action listener: _resource_record_pre_action 04:57:56 INFO - Running main action method: read_buildbot_config 04:57:56 INFO - Using buildbot properties: 04:57:56 INFO - { 04:57:56 INFO - "project": "", 04:57:56 INFO - "product": "firefox", 04:57:56 INFO - "script_repo_revision": "production", 04:57:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:57:56 INFO - "repository": "", 04:57:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:57:56 INFO - "buildid": "20170419030223", 04:57:56 INFO - "stage_platform": "macosx64", 04:57:56 INFO - "basedir": "/builds/slave/test", 04:57:56 INFO - "nightly_build": "True", 04:57:56 INFO - "buildnumber": 22, 04:57:56 INFO - "slavename": "t-yosemite-r7-0005", 04:57:56 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:57:56 INFO - "platform": "yosemite_r7", 04:57:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:57:56 INFO - "branch": "mozilla-central", 04:57:56 INFO - "repo_path": "mozilla-central", 04:57:56 INFO - "revision": "c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e", 04:57:56 INFO - "pgo_build": "False", 04:57:56 INFO - "builduid": "15059296d08342d4b73e158562765efa", 04:57:56 INFO - "slavebuilddir": "test" 04:57:56 INFO - } 04:57:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:57:56 INFO - Running post-action listener: _resource_record_post_action 04:57:56 INFO - [mozharness: 2017-04-19 11:57:56.893953Z] Finished read-buildbot-config step (success) 04:57:56 INFO - [mozharness: 2017-04-19 11:57:56.894070Z] Running download-and-extract step. 04:57:56 INFO - Running pre-action listener: _resource_record_pre_action 04:57:56 INFO - Running main action method: download_and_extract 04:57:56 INFO - mkdir: /builds/slave/test/build/tests 04:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:56 INFO - trying https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:57:56 INFO - Downloading https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:57:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:57:58 INFO - Downloaded 1325 bytes. 04:57:58 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:57:58 INFO - Using the following test package requirements: 04:57:58 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:58 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:57:58 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:57:58 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:58 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:57:58 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:58 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:57:58 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:58 INFO - u'jsshell-mac.zip'], 04:57:58 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:58 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:57:58 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:57:58 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:58 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:57:58 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:58 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:57:58 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:58 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:57:58 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:58 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:57:58 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:57:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:57:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:57:58 INFO - Fetch https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:58:00 INFO - Expected file size: 52609371 04:58:00 INFO - Obtained file size: 52609371 04:58:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:58:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:58:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:58:16 INFO - Fetch https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:58:19 INFO - Expected file size: 52609371 04:58:19 INFO - Obtained file size: 52609371 04:58:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:58:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:58:34 INFO - Fetch https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:58:41 INFO - Expected file size: 14408802 04:58:41 INFO - Obtained file size: 14408802 04:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:41 INFO - trying https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:58:41 INFO - Downloading https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:58:43 INFO - Downloaded 71079344 bytes. 04:58:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:58:43 INFO - mkdir: /builds/slave/test/properties 04:58:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:58:43 INFO - Writing to file /builds/slave/test/properties/build_url 04:58:43 INFO - Contents: 04:58:43 INFO - build_url:https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:58:45 INFO - Running post-action listener: _resource_record_post_action 04:58:45 INFO - Running post-action listener: set_extra_try_arguments 04:58:45 INFO - [mozharness: 2017-04-19 11:58:45.455047Z] Finished download-and-extract step (success) 04:58:45 INFO - [mozharness: 2017-04-19 11:58:45.455221Z] Running populate-webroot step. 04:58:45 INFO - Running pre-action listener: _resource_record_pre_action 04:58:45 INFO - Running main action method: populate_webroot 04:58:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:58:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:58:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:58:45 INFO - '--tppagecycles', 04:58:45 INFO - '7'], 04:58:45 INFO - 'tests': ['tsvgm']}}, 04:58:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:58:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:58:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:58:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:58:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:58:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:58:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:58:45 INFO - 'talos_options': ['--disable-e10s'], 04:58:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:58:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:58:45 INFO - 'talos_options': ['--disable-e10s'], 04:58:45 INFO - 'tests': ['damp', 'tps']}, 04:58:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:58:45 INFO - 'tests': ['damp', 'tps']}, 04:58:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:58:45 INFO - 'tests': ['dromaeo_dom']}, 04:58:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:58:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:58:45 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:58:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:58:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:58:45 INFO - 'tests': ['a11yr', 04:58:45 INFO - 'ts_paint', 04:58:45 INFO - 'tpaint', 04:58:45 INFO - 'sessionrestore', 04:58:45 INFO - 'sessionrestore_no_auto_restore', 04:58:45 INFO - 'tabpaint']}, 04:58:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:58:45 INFO - 'ts_paint', 04:58:45 INFO - 'tpaint', 04:58:45 INFO - 'sessionrestore', 04:58:45 INFO - 'sessionrestore_no_auto_restore', 04:58:45 INFO - 'tabpaint']}, 04:58:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:58:45 INFO - 'ts_paint', 04:58:45 INFO - 'tpaint', 04:58:45 INFO - 'sessionrestore', 04:58:45 INFO - 'sessionrestore_no_auto_restore', 04:58:45 INFO - 'tabpaint']}, 04:58:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:58:45 INFO - 'ts_paint', 04:58:45 INFO - 'tpaint', 04:58:45 INFO - 'sessionrestore', 04:58:45 INFO - 'sessionrestore_no_auto_restore', 04:58:45 INFO - 'tabpaint']}, 04:58:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:58:45 INFO - 'tests': ['a11yr', 04:58:45 INFO - 'ts_paint', 04:58:45 INFO - 'tpaint', 04:58:45 INFO - 'sessionrestore', 04:58:45 INFO - 'sessionrestore_no_auto_restore', 04:58:45 INFO - 'tabpaint']}, 04:58:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:58:45 INFO - 'tests': ['a11yr', 04:58:45 INFO - 'ts_paint', 04:58:45 INFO - 'tpaint', 04:58:45 INFO - 'sessionrestore', 04:58:45 INFO - 'sessionrestore_no_auto_restore', 04:58:45 INFO - 'tabpaint']}, 04:58:45 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:58:45 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:58:45 INFO - 'bloom_basic_ref']}, 04:58:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:58:45 INFO - 'tests': ['tsvgx', 04:58:45 INFO - 'tsvgr_opacity', 04:58:45 INFO - 'tart', 04:58:45 INFO - 'tscrollx', 04:58:45 INFO - 'cart', 04:58:45 INFO - 'tsvg_static']}, 04:58:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:58:45 INFO - 'tsvgr_opacity', 04:58:45 INFO - 'tart', 04:58:45 INFO - 'tscrollx', 04:58:45 INFO - 'cart', 04:58:45 INFO - 'tsvg_static']}, 04:58:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:58:45 INFO - 'talos_options': ['--disable-e10s'], 04:58:45 INFO - 'tests': ['tp5o']}, 04:58:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:58:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:58:45 INFO - 'talos_options': ['--disable-e10s', 04:58:45 INFO - '--xperf_path', 04:58:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:45 INFO - 'tests': ['tp5n']}, 04:58:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:58:45 INFO - 'talos_options': ['--xperf_path', 04:58:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:45 INFO - 'tests': ['tp5n']}}, 04:58:45 INFO - 'talos.zip': {'path': '', 04:58:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:58:45 INFO - Running post-action listener: _resource_record_post_action 04:58:45 INFO - [mozharness: 2017-04-19 11:58:45.473898Z] Finished populate-webroot step (success) 04:58:45 INFO - [mozharness: 2017-04-19 11:58:45.474034Z] Running create-virtualenv step. 04:58:45 INFO - Running pre-action listener: _resource_record_pre_action 04:58:45 INFO - Running main action method: create_virtualenv 04:58:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:58:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:58:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:58:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:58:45 INFO - Using real prefix '/tools/python27' 04:58:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:58:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:58:49 INFO - Installing pip.................done. 04:58:49 INFO - Return code: 0 04:58:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:58:49 INFO - Reading from file tmpfile_stdout 04:58:49 INFO - Output received: 04:58:49 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:58:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:50 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 0x10b6bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a625788d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b49dd30>, '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 0x10b3c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b492be8>, '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.ypHf3kmtML/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.zk24HIRC9L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:58:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypHf3kmtML/Render', 04:58:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:50 INFO - 'HOME': '/Users/cltbld', 04:58:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:50 INFO - 'LOGNAME': 'cltbld', 04:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:50 INFO - 'MOZ_NO_REMOTE': '1', 04:58:50 INFO - 'NO_EM_RESTART': '1', 04:58:50 INFO - 'PAGER': '/bin/cat', 04:58:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:50 INFO - 'PWD': '/builds/slave/test', 04:58:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:50 INFO - 'SHELL': '/bin/bash', 04:58:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zk24HIRC9L/Listeners', 04:58:50 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:58:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:50 INFO - 'USER': 'cltbld', 04:58:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:50 INFO - 'XPC_FLAGS': '0x0', 04:58:50 INFO - 'XPC_SERVICE_NAME': '0', 04:58:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:58:50 INFO - Cleaning up... 04:58:50 INFO - Return code: 0 04:58:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:51 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 0x10b6bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a625788d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b49dd30>, '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 0x10b3c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b492be8>, '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.ypHf3kmtML/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.zk24HIRC9L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:58:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypHf3kmtML/Render', 04:58:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:51 INFO - 'HOME': '/Users/cltbld', 04:58:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:51 INFO - 'LOGNAME': 'cltbld', 04:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:51 INFO - 'MOZ_NO_REMOTE': '1', 04:58:51 INFO - 'NO_EM_RESTART': '1', 04:58:51 INFO - 'PAGER': '/bin/cat', 04:58:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:51 INFO - 'PWD': '/builds/slave/test', 04:58:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:51 INFO - 'SHELL': '/bin/bash', 04:58:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zk24HIRC9L/Listeners', 04:58:51 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:58:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:51 INFO - 'USER': 'cltbld', 04:58:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:51 INFO - 'XPC_FLAGS': '0x0', 04:58:51 INFO - 'XPC_SERVICE_NAME': '0', 04:58:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:51 INFO - Downloading/unpacking psutil>=3.1.1 04:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:55 INFO - Installing collected packages: psutil 04:58:55 INFO - Running setup.py install for psutil 04:58:55 INFO - building 'psutil._psutil_osx' extension 04:58:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:58:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:58:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:58:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:58:56 INFO - building 'psutil._psutil_posix' extension 04:58:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:58:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:58:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:58:56 INFO - ^ 04:58:56 INFO - 1 warning generated. 04:58:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:58:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:56 INFO - Successfully installed psutil 04:58:56 INFO - Cleaning up... 04:58:57 INFO - Return code: 0 04:58:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:57 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 0x10b6bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a625788d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b49dd30>, '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 0x10b3c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b492be8>, '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.ypHf3kmtML/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.zk24HIRC9L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:58:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypHf3kmtML/Render', 04:58:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:57 INFO - 'HOME': '/Users/cltbld', 04:58:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:57 INFO - 'LOGNAME': 'cltbld', 04:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:57 INFO - 'MOZ_NO_REMOTE': '1', 04:58:57 INFO - 'NO_EM_RESTART': '1', 04:58:57 INFO - 'PAGER': '/bin/cat', 04:58:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:57 INFO - 'PWD': '/builds/slave/test', 04:58:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:57 INFO - 'SHELL': '/bin/bash', 04:58:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zk24HIRC9L/Listeners', 04:58:57 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:58:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:57 INFO - 'USER': 'cltbld', 04:58:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:57 INFO - 'XPC_FLAGS': '0x0', 04:58:57 INFO - 'XPC_SERVICE_NAME': '0', 04:58:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:59:01 INFO - Installing collected packages: mozsystemmonitor 04:59:01 INFO - Running setup.py install for mozsystemmonitor 04:59:01 INFO - Successfully installed mozsystemmonitor 04:59:01 INFO - Cleaning up... 04:59:01 INFO - Return code: 0 04:59:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:01 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 0x10b6bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a625788d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b49dd30>, '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 0x10b3c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b492be8>, '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.ypHf3kmtML/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.zk24HIRC9L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:59:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypHf3kmtML/Render', 04:59:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:01 INFO - 'HOME': '/Users/cltbld', 04:59:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:01 INFO - 'LOGNAME': 'cltbld', 04:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:01 INFO - 'MOZ_NO_REMOTE': '1', 04:59:01 INFO - 'NO_EM_RESTART': '1', 04:59:01 INFO - 'PAGER': '/bin/cat', 04:59:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:01 INFO - 'PWD': '/builds/slave/test', 04:59:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:01 INFO - 'SHELL': '/bin/bash', 04:59:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zk24HIRC9L/Listeners', 04:59:01 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:59:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:01 INFO - 'USER': 'cltbld', 04:59:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:01 INFO - 'XPC_FLAGS': '0x0', 04:59:01 INFO - 'XPC_SERVICE_NAME': '0', 04:59:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:01 INFO - Downloading/unpacking jsonschema==2.5.1 04:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:59:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:59:06 INFO - warning: no files found matching '*.txt' 04:59:06 INFO - no previously-included directories found matching 'build' 04:59:06 INFO - no previously-included directories found matching 'dist' 04:59:06 INFO - no previously-included directories found matching '.git*' 04:59:06 INFO - Installing collected packages: jsonschema, functools32 04:59:06 INFO - Running setup.py install for functools32 04:59:06 INFO - warning: no files found matching '*.txt' 04:59:06 INFO - no previously-included directories found matching 'build' 04:59:06 INFO - no previously-included directories found matching 'dist' 04:59:06 INFO - no previously-included directories found matching '.git*' 04:59:06 INFO - Successfully installed jsonschema functools32 04:59:06 INFO - Cleaning up... 04:59:07 INFO - Return code: 0 04:59:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:07 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 0x10b6bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a625788d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b49dd30>, '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 0x10b3c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b492be8>, '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.ypHf3kmtML/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.zk24HIRC9L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:59:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypHf3kmtML/Render', 04:59:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:07 INFO - 'HOME': '/Users/cltbld', 04:59:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:07 INFO - 'LOGNAME': 'cltbld', 04:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:07 INFO - 'MOZ_NO_REMOTE': '1', 04:59:07 INFO - 'NO_EM_RESTART': '1', 04:59:07 INFO - 'PAGER': '/bin/cat', 04:59:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:07 INFO - 'PWD': '/builds/slave/test', 04:59:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:07 INFO - 'SHELL': '/bin/bash', 04:59:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zk24HIRC9L/Listeners', 04:59:07 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:59:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:07 INFO - 'USER': 'cltbld', 04:59:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:07 INFO - 'XPC_FLAGS': '0x0', 04:59:07 INFO - 'XPC_SERVICE_NAME': '0', 04:59:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:59:07 INFO - Cleaning up... 04:59:07 INFO - Return code: 0 04:59:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:07 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 0x10b6bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a625788d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b49dd30>, '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 0x10b3c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b492be8>, '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.ypHf3kmtML/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.zk24HIRC9L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:59:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypHf3kmtML/Render', 04:59:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:07 INFO - 'HOME': '/Users/cltbld', 04:59:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:07 INFO - 'LOGNAME': 'cltbld', 04:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:07 INFO - 'MOZ_NO_REMOTE': '1', 04:59:07 INFO - 'NO_EM_RESTART': '1', 04:59:07 INFO - 'PAGER': '/bin/cat', 04:59:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:07 INFO - 'PWD': '/builds/slave/test', 04:59:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:07 INFO - 'SHELL': '/bin/bash', 04:59:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zk24HIRC9L/Listeners', 04:59:07 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:59:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:07 INFO - 'USER': 'cltbld', 04:59:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:07 INFO - 'XPC_FLAGS': '0x0', 04:59:07 INFO - 'XPC_SERVICE_NAME': '0', 04:59:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:07 INFO - Downloading/unpacking blobuploader==1.2.4 04:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:11 INFO - Downloading blobuploader-1.2.4.tar.gz 04:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:59:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:59:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:12 INFO - Downloading docopt-0.6.1.tar.gz 04:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:59:12 INFO - Installing collected packages: blobuploader, requests, docopt 04:59:12 INFO - Running setup.py install for blobuploader 04:59:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:59:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:59:12 INFO - Running setup.py install for requests 04:59:13 INFO - Running setup.py install for docopt 04:59:13 INFO - Successfully installed blobuploader requests docopt 04:59:13 INFO - Cleaning up... 04:59:13 INFO - Return code: 0 04:59:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:13 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 0x10b6bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a625788d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b49dd30>, '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 0x10b3c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b492be8>, '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.ypHf3kmtML/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.zk24HIRC9L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypHf3kmtML/Render', 04:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:13 INFO - 'HOME': '/Users/cltbld', 04:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:13 INFO - 'LOGNAME': 'cltbld', 04:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:13 INFO - 'MOZ_NO_REMOTE': '1', 04:59:13 INFO - 'NO_EM_RESTART': '1', 04:59:13 INFO - 'PAGER': '/bin/cat', 04:59:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:13 INFO - 'PWD': '/builds/slave/test', 04:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:13 INFO - 'SHELL': '/bin/bash', 04:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zk24HIRC9L/Listeners', 04:59:13 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:13 INFO - 'USER': 'cltbld', 04:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:13 INFO - 'XPC_FLAGS': '0x0', 04:59:13 INFO - 'XPC_SERVICE_NAME': '0', 04:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:59:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-BW5SJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:59:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-j3DMVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:59:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-JkKTwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:59:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Uws2p6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:59:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-JpYgyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:59:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-w_yJyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:59:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-0GI1s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:59:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-foH9z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:59:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-6IYBxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:59:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-OksbHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:59:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-3b5UBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:59:14 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-sVSjeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:59:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ixGjx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:59:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-lSYHAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-zL4iGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:59:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-fN31bU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:59:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-GCmoi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:59:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:59:15 INFO - Running setup.py install for manifestparser 04:59:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:59:15 INFO - Running setup.py install for mozcrash 04:59:15 INFO - Running setup.py install for mozdebug 04:59:15 INFO - Running setup.py install for mozdevice 04:59:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:59:16 INFO - Running setup.py install for mozfile 04:59:16 INFO - Running setup.py install for mozhttpd 04:59:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:59:16 INFO - Running setup.py install for mozinfo 04:59:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:59:16 INFO - Running setup.py install for mozInstall 04:59:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:59:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:59:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:59:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:59:16 INFO - Running setup.py install for mozleak 04:59:16 INFO - Running setup.py install for mozlog 04:59:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:59:17 INFO - Running setup.py install for moznetwork 04:59:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:59:17 INFO - Running setup.py install for mozprocess 04:59:17 INFO - Running setup.py install for mozprofile 04:59:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:59:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:59:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:59:17 INFO - Running setup.py install for mozrunner 04:59:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:59:17 INFO - Running setup.py install for mozscreenshot 04:59:17 INFO - Running setup.py install for moztest 04:59:17 INFO - Running setup.py install for mozversion 04:59:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:59:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:59:18 INFO - Cleaning up... 04:59:18 INFO - Return code: 0 04:59:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:18 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 0x10b6bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a625788d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b49dd30>, '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 0x10b3c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b492be8>, '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.ypHf3kmtML/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.zk24HIRC9L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:59:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypHf3kmtML/Render', 04:59:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:18 INFO - 'HOME': '/Users/cltbld', 04:59:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:18 INFO - 'LOGNAME': 'cltbld', 04:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:18 INFO - 'MOZ_NO_REMOTE': '1', 04:59:18 INFO - 'NO_EM_RESTART': '1', 04:59:18 INFO - 'PAGER': '/bin/cat', 04:59:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:18 INFO - 'PWD': '/builds/slave/test', 04:59:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:18 INFO - 'SHELL': '/bin/bash', 04:59:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zk24HIRC9L/Listeners', 04:59:18 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:59:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:18 INFO - 'USER': 'cltbld', 04:59:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:18 INFO - 'XPC_FLAGS': '0x0', 04:59:18 INFO - 'XPC_SERVICE_NAME': '0', 04:59:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:59:18 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-KIA9vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:59:18 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-yxWnHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:59:18 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-MZq4qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:59:18 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-VYHK8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:59:18 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ayOx8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:59:18 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Rry4AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:59:18 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-FBAABX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:59:19 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-k6XV76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:59:19 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-WNUsI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:59:19 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-cAZHzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:59:19 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-XlIHun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:59:19 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Pj1Xbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:59:19 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-6Ey42n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:59:19 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Yj4bxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:19 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-7MpQqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:59:19 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-JoVszo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:59:20 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Xmy1bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:59:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:23 INFO - Downloading blessings-1.6.tar.gz 04:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:59:23 INFO - Installing collected packages: blessings 04:59:23 INFO - Running setup.py install for blessings 04:59:23 INFO - Successfully installed blessings 04:59:23 INFO - Cleaning up... 04:59:23 INFO - Return code: 0 04:59:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:59:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:59:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:59:24 INFO - Reading from file tmpfile_stdout 04:59:24 INFO - Current package versions: 04:59:24 INFO - blessings == 1.6 04:59:24 INFO - blobuploader == 1.2.4 04:59:24 INFO - docopt == 0.6.1 04:59:24 INFO - functools32 == 3.2.3-2 04:59:24 INFO - jsonschema == 2.5.1 04:59:24 INFO - manifestparser == 1.1 04:59:24 INFO - mozInstall == 1.12 04:59:24 INFO - mozcrash == 1.0 04:59:24 INFO - mozdebug == 0.1 04:59:24 INFO - mozdevice == 0.50 04:59:24 INFO - mozfile == 1.2 04:59:24 INFO - mozhttpd == 0.7 04:59:24 INFO - mozinfo == 0.9 04:59:24 INFO - mozleak == 0.1 04:59:24 INFO - mozlog == 3.4 04:59:24 INFO - moznetwork == 0.27 04:59:24 INFO - mozprocess == 0.25 04:59:24 INFO - mozprofile == 0.28 04:59:24 INFO - mozrunner == 6.13 04:59:24 INFO - mozscreenshot == 0.1 04:59:24 INFO - mozsystemmonitor == 0.3 04:59:24 INFO - moztest == 0.8 04:59:24 INFO - mozversion == 1.4 04:59:24 INFO - psutil == 3.1.1 04:59:24 INFO - requests == 1.2.3 04:59:24 INFO - wsgiref == 0.1.2 04:59:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59: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')]} 04:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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')]} 04:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:24 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 0x10b6bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a625788d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b49dd30>, '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 0x10b3c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b492be8>, '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.ypHf3kmtML/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.zk24HIRC9L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypHf3kmtML/Render', 04:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:24 INFO - 'HOME': '/Users/cltbld', 04:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:24 INFO - 'LOGNAME': 'cltbld', 04:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:24 INFO - 'MOZ_NO_REMOTE': '1', 04:59:24 INFO - 'NO_EM_RESTART': '1', 04:59:24 INFO - 'PAGER': '/bin/cat', 04:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:24 INFO - 'PWD': '/builds/slave/test', 04:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:24 INFO - 'SHELL': '/bin/bash', 04:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zk24HIRC9L/Listeners', 04:59:24 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:24 INFO - 'USER': 'cltbld', 04:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:24 INFO - 'XPC_FLAGS': '0x0', 04:59:24 INFO - 'XPC_SERVICE_NAME': '0', 04:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:59:24 INFO - Cleaning up... 04:59:24 INFO - Return code: 0 04:59:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:59: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')]} 04:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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')]} 04:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a625788d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b49dd30>, '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 0x10b3c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b492be8>, '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.ypHf3kmtML/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.zk24HIRC9L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59: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', 'jsonschema'] in /builds/slave/test/build 04:59: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 jsonschema 04:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypHf3kmtML/Render', 04:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:24 INFO - 'HOME': '/Users/cltbld', 04:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:24 INFO - 'LOGNAME': 'cltbld', 04:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:24 INFO - 'MOZ_NO_REMOTE': '1', 04:59:24 INFO - 'NO_EM_RESTART': '1', 04:59:24 INFO - 'PAGER': '/bin/cat', 04:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:24 INFO - 'PWD': '/builds/slave/test', 04:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:24 INFO - 'SHELL': '/bin/bash', 04:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zk24HIRC9L/Listeners', 04:59:24 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:24 INFO - 'USER': 'cltbld', 04:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:24 INFO - 'XPC_FLAGS': '0x0', 04:59:24 INFO - 'XPC_SERVICE_NAME': '0', 04:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:59:24 INFO - Cleaning up... 04:59:24 INFO - Return code: 0 04:59:24 INFO - Running post-action listener: _resource_record_post_action 04:59:24 INFO - Running post-action listener: _start_resource_monitoring 04:59:24 INFO - Starting resource monitoring. 04:59:24 INFO - [mozharness: 2017-04-19 11:59:24.695324Z] Finished create-virtualenv step (success) 04:59:24 INFO - [mozharness: 2017-04-19 11:59:24.696285Z] Running install step. 04:59:24 INFO - Running pre-action listener: _resource_record_pre_action 04:59:24 INFO - Running main action method: install 04:59:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:59:24 INFO - Reading from file tmpfile_stdout 04:59:24 INFO - Detecting whether we're running mozinstall >=1.0... 04:59:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:59:25 INFO - Reading from file tmpfile_stdout 04:59:25 INFO - Output received: 04:59:25 INFO - Usage: mozinstall [options] installer 04:59:25 INFO - Options: 04:59:25 INFO - -h, --help show this help message and exit 04:59:25 INFO - -d DEST, --destination=DEST 04:59:25 INFO - Directory to install application into. [default: 04:59:25 INFO - "/builds/slave/test"] 04:59:25 INFO - --app=APP Application being installed. [default: firefox] 04:59:25 INFO - mkdir: /builds/slave/test/build/application 04:59:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:59:44 INFO - Reading from file tmpfile_stdout 04:59:44 INFO - Output received: 04:59:44 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:59:44 INFO - Running post-action listener: _resource_record_post_action 04:59:44 INFO - [mozharness: 2017-04-19 11:59:44.971328Z] Finished install step (success) 04:59:44 INFO - [mozharness: 2017-04-19 11:59:44.971465Z] Running run-tests step. 04:59:44 INFO - Running pre-action listener: _resource_record_pre_action 04:59:44 INFO - Running main action method: run_tests 04:59:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:44 INFO - 2017-04-19 04:59:44.985 screenresolution[1630:7516] starting screenresolution argv=screenresolution get 04:59:44 INFO - 2017-04-19 04:59:44.988 screenresolution[1630:7516] Display 0: 1600x1200x32@60 04:59:44 INFO - 2017-04-19 04:59:44.994 screenresolution[1631:7519] starting screenresolution argv=screenresolution list 04:59:44 INFO - Available Modes on Display 0 04:59:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:45 INFO - Intel Iris: 04:59:45 INFO - Chipset Model: Intel Iris 04:59:45 INFO - Type: GPU 04:59:45 INFO - Bus: Built-In 04:59:45 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:45 INFO - Vendor: Intel (0x8086) 04:59:45 INFO - Device ID: 0x0a2e 04:59:45 INFO - Revision ID: 0x0009 04:59:45 INFO - Displays: 04:59:45 INFO - Display: 04:59:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:45 INFO - Display Serial Number: 1600x1200 60 04:59:45 INFO - Main Display: Yes 04:59:45 INFO - Mirror: Off 04:59:45 INFO - Online: Yes 04:59:45 INFO - Rotation: Supported 04:59:45 INFO - Return code: 0 04:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:59:45 INFO - Python 2.7.3 04:59:45 INFO - Return code: 0 04:59:45 INFO - grabbing minidump binary from tooltool 04:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:45 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 0x10b49dd30>, '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 0x10b3c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b492be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:59:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:59:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:59:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:59:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:59:45 INFO - Return code: 0 04:59:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:59:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:59:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:59:45 INFO - ENV: RUST_BACKTRACE is now 1 04:59:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:59:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:59:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ypHf3kmtML/Render', 04:59:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:45 INFO - 'HOME': '/Users/cltbld', 04:59:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:45 INFO - 'LOGNAME': 'cltbld', 04:59:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:59:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:45 INFO - 'MOZ_NO_REMOTE': '1', 04:59:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:59:45 INFO - 'NO_EM_RESTART': '1', 04:59:45 INFO - 'PAGER': '/bin/cat', 04:59:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:45 INFO - 'PWD': '/builds/slave/test', 04:59:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:59:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:45 INFO - 'RUST_BACKTRACE': '1', 04:59:45 INFO - 'SHELL': '/bin/bash', 04:59:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zk24HIRC9L/Listeners', 04:59:45 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:59:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:45 INFO - 'USER': 'cltbld', 04:59:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:45 INFO - 'XPC_FLAGS': '0x0', 04:59:45 INFO - 'XPC_SERVICE_NAME': '0', 04:59:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:59:45 INFO - mozversion application_buildid: 20170419030223 04:59:45 INFO - mozversion application_changeset: c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e 04:59:45 INFO - mozversion application_display_name: Nightly 04:59:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:59:45 INFO - mozversion application_name: Firefox 04:59:45 INFO - mozversion application_remotingname: firefox 04:59:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:59:45 INFO - mozversion application_vendor: Mozilla 04:59:45 INFO - mozversion application_version: 55.0a1 04:59:45 INFO - mozversion platform_buildid: 20170419030223 04:59:45 INFO - mozversion platform_changeset: c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e 04:59:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:59:45 INFO - mozversion platform_version: 55.0a1 04:59:45 INFO - using testdate: 1492603185 04:59:45 INFO - actual date: 1492603185 04:59:45 INFO - starting webserver on 'localhost:49243' 04:59:45 INFO - SUITE-START | Running 2 tests 04:59:45 INFO - TEST-START | dromaeo_css 04:59:45 INFO - operating with platform_type : mac_ 04:59:45 INFO - Initialising browser for dromaeo_css test... 04:59:45 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpQ0GOq7/profile http://localhost:49243/getInfo.html) 04:59:48 INFO - PID 1641 | __metrics Screen width/height:1600/1200 04:59:48 INFO - PID 1641 | colorDepth:24 04:59:48 INFO - PID 1641 | Browser inner width/height: 1024/689 04:59:48 INFO - PID 1641 | __metrics 04:59:48 INFO - PID 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:59:48 INFO - PID 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:59:49 INFO - TEST-INFO | 1641: exit 0 04:59:49 INFO - Browser initialized. 04:59:49 INFO - Running cycle 1/1 for dromaeo_css test... 04:59:49 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpQ0GOq7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:01 INFO - PID 1645 | RSS: Main: 241315840 05:00:01 INFO - PID 1645 | 05:03:07 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 05:03:09 INFO - PID 1645 | RSS: Main: 473841664 05:03:09 INFO - PID 1645 | 05:04:51 INFO - PID 1645 | ************************* 05:04:51 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 05:04:51 INFO - PID 1645 | 05:04:51 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:04:51 INFO - PID 1645 | Full stack: 05:04:51 INFO - PID 1645 | ************************* 05:04:51 INFO - PID 1645 | ************************* 05:04:51 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 05:04:51 INFO - PID 1645 | 05:04:51 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:04:51 INFO - PID 1645 | Full stack: 05:04:51 INFO - PID 1645 | ************************* 05:04:51 INFO - PID 1645 | ************************* 05:04:51 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 05:04:51 INFO - PID 1645 | 05:04:51 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:04:51 INFO - PID 1645 | Full stack: 05:04:51 INFO - PID 1645 | ************************* 05:04:51 INFO - PID 1645 | ************************* 05:04:51 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 05:04:51 INFO - PID 1645 | 05:04:51 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:04:51 INFO - PID 1645 | Full stack: 05:04:51 INFO - PID 1645 | ************************* 05:06:12 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 05:06:12 INFO - PID 1645 | RSS: Main: 371425280 05:06:12 INFO - PID 1645 | 05:09:15 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 05:09:15 INFO - PID 1645 | RSS: Main: 334282752 05:09:15 INFO - PID 1645 | 05:12:18 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 05:12:18 INFO - PID 1645 | RSS: Main: 335679488 05:12:18 INFO - PID 1645 | 05:15:22 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 05:15:23 INFO - PID 1645 | RSS: Main: 336928768 05:15:23 INFO - PID 1645 | 05:18:25 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 05:18:25 INFO - PID 1645 | RSS: Main: 374411264 05:18:25 INFO - PID 1645 | 05:18:25 INFO - PID 1645 | __start_tp_report 05:18:25 INFO - PID 1645 | _x_x_mozilla_page_load 05:18:25 INFO - PID 1645 | _x_x_mozilla_page_load_details 05:18:25 INFO - PID 1645 | |i|pagename|runs| 05:18:25 INFO - PID 1645 | |0;dojo.html;3490.319387719394;3495.5980062292842;3514.086337552236;3529.9294014119732;3540.876069337572;5813.30240371155;5938.10928360745;6182.196314479117;6220.6267623942485;6240.719167637456;5969.671668058255;6004.759809607622;6018.277806663195;6024.819255422333;6029.366916473773;4391.890202744925;5223.869403264911;5253.080710875582;5287.233351164079;5319.042572336978;5356.4107948125675;5420.1327787554;5435.130379139338;5442.591805614575;5488.451154884519;5414.620976531624;5417.891642167155;5420.403755586883;5438.075527160372;5441.891162176754;5136.43499215086;5284.260203571503;5411.945880541223;5415.864603384927;5494.890102197934;5315.734213289359;5331.973340133313;5342.893142137174;5382.111951527993;5396.082665946798;6063.242094738158;6115.235595550556;6143.78496752616;6151.108089327023;6160;6350.745970161188;6441.645709485976;6459.903101453482;6484.221893372825;6488.0916671666;6146.016637338004;6370.4266616004315;6493.675316234217;6549.770758023494;6559.2128944526485;6225.315215326311;6241.126242326078;6248.062790581358;6257.311695713468;6260.060990851318;6689.297623749533;6726.327367263235;6735.797926062226;6742.426893713991;6742.49431292655;6264.812055638247;6289.937100629027;6360.459360954278;6373.330800265998;6393.6163830170335;6533.477321814244;6543.705533251015;6554.279029306867;6572.704228309737;6589.110470086573;6289.276733175652;6341.143945567382;6420.6147631142285;6429.7749578764515;6431.42117209444;6372.490200783926;6411.358864113645;6411.839704007344;6420.454261387741;6455.064015717695;5249.553787928069;5276.788928442896;5292.391374991848;5316.787328506816;5320.600954928396;4561.794719237642;4706.152892479318;4718.834840780556;4723.385959825269;4759.571638552547;6079.179310792986;6087.391260873877;6105.572609917263;6105.938940610537;6107.450329470369;6357.841053973595;6358.554901156967;6384.265809431975;6384.52116091295;6388;5023.8492845214705;5094.541491265803;6045.637261764308;6074.696265186723;6097.908531372033;5591.161325801162;5670.773169073191;5672.886542269214;5674.659520428788;5678;6538.640374779433;6542.869142617121;6689.698963546554;6740.730370785113;6770.593764374154;6542.54202205841;6575.80272591823;6590.7693230736695;6594.142761440982;6596.241432235354;6778.254392016973;6787;6811.352921472452;6820.283870193558;6836.008778727156;6301.495880329471;6374.872502549831;6418.293987661447;6432.35676432353;6446.226452825691;6478.481721462177;6509.446697030806;6522.608643481406;6528.738850445929;6538.248101468392;5067.5185857343495;5964.731587078505;6349.6507692077375;6352.68236588178;6365.2361716594305;6293.590916590407;6338.429541341301;6339.746410143543;6340.112384266298;6381.489480841615;6129.84675383119;6130.540209484396;6165.414285642857;6169.167162433014;6182.165407670087;6295.527835412454;6300.2754683212015;6307.90538141919;6324.304326523987;6331.873362532631;6133.946794548555;6183.103449999815;6256;6314.463270622048;6363 05:18:25 INFO - PID 1645 | |1;ext.html;788.7594283743458;805.5891495337378;1103.9337639741616;1116.8324751287312;1123.561810893751;31423.21441963949;31962.721491140357;34375.82812085939;34987.4751878722;34992.82503587485;28319;37159.4426083609;37593.81203093981;37656.81171594138;37666;5912.674802885839;6025.638461692291;8139;8283.420160588761;8288.668453261862;5881.558883083786;5993.46058854703;5997.190379298782;8129.512229266263;8275.08974012858;8354.24811766941;8354.331653467709;8360.749177524654;8364.498130112182;8370.33037357013;8279.296259817893;8338.999999999969;8346.707865224687;8355.874661880076;8398.580070996426;8158.184181581853;8210.794730131794;8211.05572859123;8211.876821847676;8217.383696222807;35618.753343632845;35667.28665426703;35720.46419303712;35764;35794.64205357965;3534.7525673202886;3555;3558.1460449492192;3561.5904171020147;3563.679268865789;29006.12981610534;29118.27204319888;29169.979050733124;29184.562231566542;29191.85404072987;3079.3687294104657;3099.0547882895708;3139.199504126456;3145.072203699914;3151.8108913465267;200721;267279;268977;269589;270253;37752;38178.045548860944;38281;45762.77118614386;45962.31056534155;48119.51880481221;48469.27296090561;48664.51335486671;48817.75591122093;48818.75590622024;13270.535531256359;13339.132956357806;13360.33198340079;13381.66545836362;13382.13016153947;10922.399268040175;10925.726856828644;10934.781304373868;10950.178736594788;10962.506687199095;11677.91273054441;11681.88318116825;11683;11707.707307317214;11805.527778888749;4058.330375488011;4732.858014259577;5169.71566563835;5177.326947496801;5188.351456067991;996.3573495095623;1008.1531513528671;1036.7667274863247;1037.4968140451874;1057.603398725478;23702.05191792309;23719.288421347388;23778.929948152374;23802.404939876295;24133.637995430083;1085.3813326403874;1093.8359246113146;1128.960486382989;1137.0960086731068;1152.262551966742;11582.247153934968;12203.694907627203;12205.69485762863;12206.389680515938;12261.325627090595;300695.496522516;301839;302469;302559;303116.4844175809;50680.746596266785;50699.746501267255;50735.746321268896;50803.23795143076;50932.72668183325;1474.2260313335585;1518.301581272627;1528.5414375687471;1535.2477286129715;1542.3830467812966;23382.298531044096;23512.764872351057;23533.529329413657;23638.409039774142;23767.405814854767;36391.09022274464;36443;36451;36571.634283657884;36573.817130914176;278664;278766;279151;279365;279398;28025.71974280231;28153.31218362459;31305.53041704331;32960.83519582387;33135;40313.59686403099;41063.1787364257;41140;41145.148468319596;41212.793936030124;27943.580846286914;28101.859490702416;29573.408531828813;30391.544126837674;30473.847630761706;27866.30334241579;29317.973870914415;29512.409751804415;29925.401491970475;30321.24196895095;36450.45324320084;36526.817365913;36614;36619.81690091533;36645;25833.870830645727;28408.00571979971;28776.85611571929;29569.85215073911;30384.26098866891;22056.779432206113;23230;23318.766812331658;23490.64764028575;23915.641265381382 05:18:25 INFO - PID 1645 | |2;jquery.html;423.2135039159411;429.6262251840899;432.37305906435654;441.3996964128784;456.44580204403997;18236.544086397847;18612.883227006354;20663.483412914666;21434.464138396528;21493.03281352339;21443.785562144374;22076.88961555194;22323.776762232374;22748.886255568697;22766;5964.642121472714;6209.348018458065;6238.844028899269;6239.095331176976;6241.531885108612;5959.195508606326;6038.033914573669;6045.214122164134;6133.723982420779;6135.3557876423;6025.668588227646;6090.360512146227;6092.390760923894;6109.511239100883;6137.079438084301;6010.939890601104;6129.1419201311855;6192.628442293431;6205.131281620576;6207.441330280274;5261.710605916673;5406.135018397077;5456.727163641842;5477.917831232495;5489.615726899118;27411.86294068537;27748.30629234265;27840.30399240015;27930.3017424564;27933;2147.3879944215823;2210.2816584609905;2210.701555290031;2215.8670479771267;2217.0577504560497;17842;17916.372926947624;17936.641267174713;18154.18306176225;18416;1894.6873765828623;2145.626798848738;2164.1343462614923;2200.185931205448;2211.3587059752654;162846;164094.17952910278;166171;166690;167706.1614691931;12076.396180190955;12088.939555302168;12287.324197169062;12308.938455307667;12544.874551254554;16624.750628740338;16629.251683674265;16640;16662.250198741087;16758.497245082668;8756.8686469703;8812.427192232484;8880.289576833839;8970.237529809909;8983.910160898307;8272.627731751965;8290.129536398712;8297.792555186168;8464.111268316861;8465.534395608178;7720.498167619086;7866.410019248465;7867.449278550561;7889;7922.643481043367;1817.2367605605677;2053.712480252766;2070.0477780221267;2144.538924131319;2150.139944022372;953.6471505542994;960.3661583354952;986.7434467038478;997.6159178716247;998.0867506231862;19896.801031989784;21352.039158237916;21363.03866326019;21530.0654891843;21626.35120946374;960.279790157382;963.8843338799389;1002.904724051214;1005.7435353984833;1011.2112552209142;9082.22801061904;10565.577376904837;10902.618408355669;10907.509162087725;11011.559537618405;517895;528849;529730;558315;559913;132823;136787;136995;141494;143968;1158.0921446938592;1173.049829637996;1196.4795314038422;1197.694587880085;1200.2858299311895;17141.228644711267;18048;18080.457586272434;18167.45497635073;18640.627187456445;54934.72532637311;56856.71571642115;59374.81250374882;59458.405415945286;59501.70249148727;73873;75130;75133.62433187799;75804.62097689476;76194.23805762093;8516.361272904682;8604.956975215335;8752.69365572202;9058.818823623622;9235.445873247627;12048.819267711167;13728.382222799799;14100.858991409954;14115.505957291856;14562.927185364006;9620.619722221023;11722.062235021349;11870.525178992744;12044.277343359427;12141.08941829384;11200.775984480102;11217.551297948317;11298.308280001918;11654.70863228426;11669.183157178915;11312.03847672957;11603.795278896983;11936.16446848747;11950.760984780081;12127.878721212675;7281.708731650675;8848.601812918563;8945.016048234558;8971.641134354553;9065.637374504946;11805;11866.584669536525;12104.334261615695;12132.636020919386;12161.574344897886 05:18:25 INFO - PID 1645 | |3;mootools.html;1159.153817713069;1229.4098832560371;1348.5819395987244;1397.8881689464845;1420.1975883625757;9465.621375144994;9805.607775688974;11488.483018264178;11543.191976561644;11550.884491155086;9472.715818525437;11076.944615276912;11250.66248012559;11265.662030139089;11268.549258029689;2465.8890349934204;2507.6489291499206;2509.510645424143;2513.1329691256487;2515.132279363617;2106.2101711858054;2179.8801065941366;2180.661997390399;2181.5418762059985;2181.858179218346;2135.0712440088532;2429.0890915906534;2499.0378704198924;2501.6122501012374;2510.272021113875;2474.715407728116;2503.824732268742;2505.799536037113;2509.2221411362534;2510.63595778612;2091.351680978901;2166.815820655246;2300.6894069300597;2421.7093948726265;2467.037855236459;11397.601083962105;11466.770664586662;11473.541058357656;11498.022668073223;11506.021988130935;6364.745410183587;6608.735650573972;6622.139121914121;6625.337466253336;6629.403353698142;3978.7214894957365;4173.24881521326;4350.456192975878;4359.803808828578;4360.476742790854;1123.3933675815051;1230.5323976888726;1266.2149467330314;1272.6054922973908;1273.4460509678227;16114.033158010558;16123.838761612351;16141.677166456606;16168;16171.83828161715;5686.886262274814;5859.296884373817;5861.824145275648;5907.586468947133;5977.940220597825;13490.595282141552;13510.594682159355;13519.391627376595;13531.797023044466;13532.188068715908;6593.2088149421415;6688.598684078971;6711.563748356439;6717.5297729159465;6724.9327506725285;5147.382314122329;5987.221661184019;6137.0794380842335;6172.969135154385;6184.474319682878;4060.309747342959;4349.803349308579;4467.12890986261;4502.167099086614;4525.162844873643;1287.8969682425384;1300.3343146549723;1300.3472915252778;1302.218668798732;1303.139927647748;627.7991042866239;639.7014061455253;695.4262733245093;727.5780047572396;781.2343902975116;6524.7390104396245;6735.090762747064;6896.310368963063;6958.619594138401;6961.82595435108;847.682119205298;904.3895370624801;914.410205417502;925.1627277314042;929.0848514213494;3601.2797440512004;3771.151490914522;4122.175564887035;4267.25323068468;4295.334223195409;14364.784528232085;15104.54686359411;15105.169215693022;15106.942514023913;15212.695746085237;14304.427822886968;14851.405943762129;15018.69962600742;15033.924830375998;15198.16410097433;8521.233089022018;8705.173008564303;8709.477431354138;8721.60752766127;8753.343499237582;6669.932320980512;6925.965370173117;6949.3745562899585;6961.503276795514;6977.860442791217;10218.284720069523;13346.332683365987;13408.731825363633;13645.795313070113;13673.042886997815;10764.461776910966;13110.737785244433;13799.79300310476;13800.516981905585;13816.8946484279;9390.95304523473;9410.482423466776;9512.714618561455;9571.521423928914;9628.18160456369;10507.106895913934;10628.574857005633;10636.989485998818;10639.308444951053;10640.414777187329;8686.695965641173;8778.122187781171;8878.73363799087;9044.728658140266;9192.49441280736;8807.823843523222;8870.866936996079;8910.724033546825;8991.23574496149;9060.592273347847;8072.838543228985;8088.919110809052;8126.471779334324;8161.714339998071;8189.50862948225;5986.910196347146;6035.215421995113;6045.848853778691;6082.847928801815;6158.753649853956;6068.9655172413795;6088.908666369919;6091;6091.573589848846;6112.847178820387 05:18:25 INFO - PID 1645 | |4;prototype.html;353.97877124495824;393.9881803545895;394.23715111259713;402.72738147454044;404.66210714053744;5282.286891269678;5906.911396329058;5923.73343199556;5968.910466343008;6033.245844269466;4454.933626238785;4635.443746750386;5787.565932555065;5828.912566311508;5879.911801322984;3630.49173115764;4464.665150113755;4477.776111194444;4480.798364073625;4490.865274041784;3865.4781604483314;4273.764942928137;4457.643388528926;4470.368315564811;4513.887152821173;4272.743635381887;4412.867613971586;4446.577575130357;4459.754713490756;4471.8658440246845;3577.7316701247382;4404.66964977628;4425.8229670813125;4429.557044295577;4449.644028477714;3255.967440325614;3929.7052721046034;3936.6457018868155;3938.5273767147837;3958.9318278334235;4089.85685501009;4309.526900835921;5129.461406552296;5687.289088863892;5698.743556539925;4632.3051542268595;5187.351581052369;5270.367555893279;5273.683578985235;5304.09052741013;5884.558658100616;6157.322694503601;6159.291681456601;6180.412860778219;6192.504599632019;3623.8912832615065;4215.241256573816;4491.910161796745;4494.775261236958;4502.167099086647;5642.802501912454;6125.111858780452;6212.596181248205;6373.713182906734;6410.615363078184;3517.296540691872;4593.908121837611;4598.540145985375;4604.194266003436;4619.815207391666;3963.8810835674976;4656.1608164774725;4685.367475390847;4690.530946905282;4715.269133284346;4734.26618874075;4777.700069937015;4964.205727083649;5045.949540504622;5343.385510666245;5069.746512674352;6127.724252408652;6152.107944348134;6171.9691401542705;6186.288576813634;1560.39144733554;1572.8505791949747;1601.7917670702966;1603.5510057184008;1611.5004348651955;1112.8275117356823;1121.5233525751687;1123.719070232442;1125.780472807811;1127.768807394482;5851.210086638334;5854.326752423441;5923.970380148158;5931.40685931412;5933.902228087818;5313.601479888946;5480.479354461399;5597;6439.454530912547;6478.838029049217;4775.928361074587;5755.194272801811;5786.594938354359;5893.499052580579;5908.438698323653;2658.4550167215675;3298.472244440926;3324.6509116542898;3332.5167850662;3339.7662163648797;5607.4112218217315;6203.100550420254;6329.715162817684;6519.967400162969;6577;5527.50252477279;5832.8541786454825;6341.207349081365;6449.936280266836;6498.090267362573;5436.293281873332;5821.243238378984;6196.566240363221;6577.3422657733845;6599.571027883172;5956.374580668968;6391.744330226925;6401.327860574573;6411.615303081643;6438.259600146043;5323.1216849219445;5919.076300202365;6056.939430605637;6275.278342990432;6284.402981716729;5407.297051383295;5412.8105516308315;6476.017249391684;6578.407943285128;6634.635095069624;4343.283358245981;4589.977050114728;4590.173768721662;4592.7014744041535;4611.61651504554;5705.486506214461;5761.308642962871;6394.23269207698;6407.743690252524;6507.12153859223;5873.5594830388745;6182.28903676083;6190.1952746142715;6194.535409844189;6222.284437289589;5897.67562784051;6165.352637972948;6188.257409110935;6215.564910456224;6219.314237194943;5963.7912673056235;6133.338662616533;6155.199824023028;6162.969185154046;6175.814725558241;6119.44924956756;6285.748570057147;6298.968505157445;6300.369963003663;6301.368494156883;6067.393260673897;6135.631862088289;6150.907736384047;6154.907676384768;6171.444569988723 05:18:25 INFO - PID 1645 | |5;yui.html;690.8825499665056;841.688575227166;842.5913431985485;851.2041241439255;861.3023451004686;12741.362931853406;17648.205830737614;17689.734653980202;18150.546236344097;18217.27130914765;13992.160470371784;16884.915575422136;17065.976041437523;17235.310587576514;17310.913445432754;933.9813203735938;963.210167662517;964.28642804325;965.6620182935986;969.883613966325;651.1469974333638;669.9062131301622;937.7139972308444;966.4153187321674;973.0512750068697;984.3355734878963;984.8965858584853;985.3545927417517;989.3223142147652;1020.9897901020969;979.5543027922279;980.3039841712392;981.1562056631292;981.6318880419842;1018.8064267789097;717.9676914538807;724.7028718225503;725.1298441869777;734.977950661481;760.1068744225513;15754.684906301809;16073.758893616605;16271.755923661154;16498.010119392875;16806.15969201535;16185.676286474205;16217.189140542925;16615.335386584524;16684.49946501607;16947.83052169475;11699.415029248588;12760.744785104338;13687.11033782801;13928.442862285496;14017.71964560703;3395.439752440844;3413.7269018478464;3415.863365465403;3420.538227339302;3422.247105636781;117432;118822;119811;120000;121152.39423802913;10655.84016239757;10870.94564527188;11464.31214127155;11725.882741172649;11770.646880593597;13664.521741738992;19394.903025484782;25130.623040654405;25143.119990800235;25192.622110668355;7657.157712651604;7726.420518461138;7836.764897053097;7843.490173138728;7848.489848159851;3670.8898733037518;3722.3299806034634;3739.439084137401;3749.5500539935383;3749.681277091423;4138.399932009842;4220.599043090901;4283.635890949242;4290.742555446684;4293.248681480728;901.6934242357498;934.065934065934;936.0873148679982;937.7655586103474;939.6382392778829;609.3662590905409;616.6033933141438;616.8735409241184;624.2696045626537;658.2627457247913;9847.950760246153;10379.273450858518;10520.10579100785;10646.787064258671;10913.83629245562;508.28332051806774;622.5673157155824;630.549157352486;633.2907143998659;647.7829926974422;4069.4709687740406;4143.834246630161;4716.198246298138;4849.369581954394;4938.950610493921;85059;94366;105395;105417;110194.44902775595;80700.78948815772;82636;83400;86902.56548717216;88794;68661;74139;75539.24460755433;76709.6164519185;77595;11858.881411186123;12314.322712250912;12368.319742414255;12431.75136497247;12610.684732881384;30660.693393066675;35566.28867422689;35692.82153589215;39858.800705996284;40709.79645101756;62605;64097.679511602146;66639.66680166568;69548;71920.64039679768;16257.75613365824;16303.347866085223;16309.18454077315;16446.34214631449;16733.330666773192;17827.465176044738;17974.460766177035;18456.907715461875;18554.97947612894;18560.907195463937;15368.001079929769;15594.220288985278;15615.921920390325;15659;15729.370825166865;16285.674286513966;16615.3353865844;16771.413000544922;16922.900011499212;16933.745993809855;13232.867671323163;16301.51095467138;16317.18414079315;16491;16616.584585385463;11748.353840538852;11968.640940771791;12044.638660840188;12137.393130343624;12197.878021219674;11893.643190704293;12028.398580071136;12431.502739890664;12539.996800255774;12655.11414200997 05:18:25 INFO - PID 1645 | __end_tp_report 05:18:25 INFO - PID 1645 | __start_cc_report 05:18:25 INFO - PID 1645 | _x_x_mozilla_cycle_collect,2637 05:18:25 INFO - PID 1645 | __end_cc_report 05:18:25 INFO - PID 1645 | __startTimestamp1492604305701__endTimestamp 05:18:25 INFO - PID 1645 | 05:18:25 INFO - PID 1645 | ------- Summary: start ------- 05:18:25 INFO - PID 1645 | Number of tests: 6 05:18:25 INFO - PID 1645 | 05:18:25 INFO - PID 1645 | [#0] dojo.html Cycles:165 Average:5991.73 Median:6248.06 stddev:691.52 (11.1%) stddev-sans-first:665.22 05:18:25 INFO - PID 1645 | Values: 3490.3 3495.6 3514.1 3529.9 3540.9 5813.3 5938.1 6182.2 6220.6 6240.7 5969.7 6004.8 6018.3 6024.8 6029.4 4391.9 5223.9 5253.1 5287.2 5319.0 5356.4 5420.1 5435.1 5442.6 5488.5 5414.6 5417.9 5420.4 5438.1 5441.9 5136.4 5284.3 5411.9 5415.9 5494.9 5315.7 5332.0 5342.9 5382.1 5396.1 6063.2 6115.2 6143.8 6151.1 6160.0 6350.7 6441.6 6459.9 6484.2 6488.1 6146.0 6370.4 6493.7 6549.8 6559.2 6225.3 6241.1 6248.1 6257.3 6260.1 6689.3 6726.3 6735.8 6742.4 6742.5 6264.8 6289.9 6360.5 6373.3 6393.6 6533.5 6543.7 6554.3 6572.7 6589.1 6289.3 6341.1 6420.6 6429.8 6431.4 6372.5 6411.4 6411.8 6420.5 6455.1 5249.6 5276.8 5292.4 5316.8 5320.6 4561.8 4706.2 4718.8 4723.4 4759.6 6079.2 6087.4 6105.6 6105.9 6107.5 6357.8 6358.6 6384.3 6384.5 6388.0 5023.8 5094.5 6045.6 6074.7 6097.9 5591.2 5670.8 5672.9 5674.7 5678.0 6538.6 6542.9 6689.7 6740.7 6770.6 6542.5 6575.8 6590.8 6594.1 6596.2 6778.3 6787.0 6811.4 6820.3 6836.0 6301.5 6374.9 6418.3 6432.4 6446.2 6478.5 6509.4 6522.6 6528.7 6538.2 5067.5 5964.7 6349.7 6352.7 6365.2 6293.6 6338.4 6339.7 6340.1 6381.5 6129.8 6130.5 6165.4 6169.2 6182.2 6295.5 6300.3 6307.9 6324.3 6331.9 6133.9 6183.1 6256.0 6314.5 6363.0 05:18:25 INFO - PID 1645 | 05:18:25 INFO - PID 1645 | [#1] ext.html Cycles:180 Average:42143.93 Median:3089.21 stddev:73388.96 (2375.7%) stddev-sans-first:73529.15 05:18:25 INFO - PID 1645 | Values: 788.8 805.6 1103.9 1116.8 1123.6 31423.2 31962.7 34375.8 34987.5 34992.8 28319.0 37159.4 37593.8 37656.8 37666.0 5912.7 6025.6 8139.0 8283.4 8288.7 5881.6 5993.5 5997.2 8129.5 8275.1 8354.2 8354.3 8360.7 8364.5 8370.3 8279.3 8339.0 8346.7 8355.9 8398.6 8158.2 8210.8 8211.1 8211.9 8217.4 35618.8 35667.3 35720.5 35764.0 35794.6 3534.8 3555.0 3558.1 3561.6 3563.7 29006.1 29118.3 29170.0 29184.6 29191.9 3079.4 3099.1 3139.2 3145.1 3151.8 200721.0 267279.0 268977.0 269589.0 270253.0 37752.0 38178.0 38281.0 45762.8 45962.3 48119.5 48469.3 48664.5 48817.8 48818.8 13270.5 13339.1 13360.3 13381.7 13382.1 10922.4 10925.7 10934.8 10950.2 10962.5 11677.9 11681.9 11683.0 11707.7 11805.5 4058.3 4732.9 5169.7 5177.3 5188.4 996.4 1008.2 1036.8 1037.5 1057.6 23702.1 23719.3 23778.9 23802.4 24133.6 1085.4 1093.8 1129.0 1137.1 1152.3 11582.2 12203.7 12205.7 12206.4 12261.3 300695.5 301839.0 302469.0 302559.0 303116.5 50680.7 50699.7 50735.7 50803.2 50932.7 1474.2 1518.3 1528.5 1535.2 1542.4 23382.3 23512.8 23533.5 23638.4 23767.4 36391.1 36443.0 36451.0 36571.6 36573.8 278664.0 278766.0 279151.0 279365.0 279398.0 28025.7 28153.3 31305.5 32960.8 33135.0 40313.6 41063.2 41140.0 41145.1 41212.8 27943.6 28101.9 29573.4 30391.5 30473.8 27866.3 29318.0 29512.4 29925.4 30321.2 36450.5 36526.8 36614.0 36619.8 36645.0 25833.9 28408.0 28776.9 29569.9 30384.3 22056.8 23230.0 23318.8 23490.6 23915.6 05:18:25 INFO - PID 1645 | 05:18:25 INFO - PID 1645 | [#2] jquery.html Cycles:180 Average:35713.56 Median:2213.61 stddev:92306.23 (4169.9%) stddev-sans-first:92527.14 05:18:25 INFO - PID 1645 | Values: 423.2 429.6 432.4 441.4 456.4 18236.5 18612.9 20663.5 21434.5 21493.0 21443.8 22076.9 22323.8 22748.9 22766.0 5964.6 6209.3 6238.8 6239.1 6241.5 5959.2 6038.0 6045.2 6133.7 6135.4 6025.7 6090.4 6092.4 6109.5 6137.1 6010.9 6129.1 6192.6 6205.1 6207.4 5261.7 5406.1 5456.7 5477.9 5489.6 27411.9 27748.3 27840.3 27930.3 27933.0 2147.4 2210.3 2210.7 2215.9 2217.1 17842.0 17916.4 17936.6 18154.2 18416.0 1894.7 2145.6 2164.1 2200.2 2211.4 162846.0 164094.2 166171.0 166690.0 167706.2 12076.4 12088.9 12287.3 12308.9 12544.9 16624.8 16629.3 16640.0 16662.3 16758.5 8756.9 8812.4 8880.3 8970.2 8983.9 8272.6 8290.1 8297.8 8464.1 8465.5 7720.5 7866.4 7867.4 7889.0 7922.6 1817.2 2053.7 2070.0 2144.5 2150.1 953.6 960.4 986.7 997.6 998.1 19896.8 21352.0 21363.0 21530.1 21626.4 960.3 963.9 1002.9 1005.7 1011.2 9082.2 10565.6 10902.6 10907.5 11011.6 517895.0 528849.0 529730.0 558315.0 559913.0 132823.0 136787.0 136995.0 141494.0 143968.0 1158.1 1173.0 1196.5 1197.7 1200.3 17141.2 18048.0 18080.5 18167.5 18640.6 54934.7 56856.7 59374.8 59458.4 59501.7 73873.0 75130.0 75133.6 75804.6 76194.2 8516.4 8605.0 8752.7 9058.8 9235.4 12048.8 13728.4 14100.9 14115.5 14562.9 9620.6 11722.1 11870.5 12044.3 12141.1 11200.8 11217.6 11298.3 11654.7 11669.2 11312.0 11603.8 11936.2 11950.8 12127.9 7281.7 8848.6 8945.0 8971.6 9065.6 11805.0 11866.6 12104.3 12132.6 12161.6 05:18:25 INFO - PID 1645 | 05:18:25 INFO - PID 1645 | [#3] mootools.html Cycles:180 Average:7060.29 Median:4091.24 stddev:4477.84 (109.4%) stddev-sans-first:4468.44 05:18:25 INFO - PID 1645 | Values: 1159.2 1229.4 1348.6 1397.9 1420.2 9465.6 9805.6 11488.5 11543.2 11550.9 9472.7 11076.9 11250.7 11265.7 11268.5 2465.9 2507.6 2509.5 2513.1 2515.1 2106.2 2179.9 2180.7 2181.5 2181.9 2135.1 2429.1 2499.0 2501.6 2510.3 2474.7 2503.8 2505.8 2509.2 2510.6 2091.4 2166.8 2300.7 2421.7 2467.0 11397.6 11466.8 11473.5 11498.0 11506.0 6364.7 6608.7 6622.1 6625.3 6629.4 3978.7 4173.2 4350.5 4359.8 4360.5 1123.4 1230.5 1266.2 1272.6 1273.4 16114.0 16123.8 16141.7 16168.0 16171.8 5686.9 5859.3 5861.8 5907.6 5977.9 13490.6 13510.6 13519.4 13531.8 13532.2 6593.2 6688.6 6711.6 6717.5 6724.9 5147.4 5987.2 6137.1 6173.0 6184.5 4060.3 4349.8 4467.1 4502.2 4525.2 1287.9 1300.3 1300.3 1302.2 1303.1 627.8 639.7 695.4 727.6 781.2 6524.7 6735.1 6896.3 6958.6 6961.8 847.7 904.4 914.4 925.2 929.1 3601.3 3771.2 4122.2 4267.3 4295.3 14364.8 15104.5 15105.2 15106.9 15212.7 14304.4 14851.4 15018.7 15033.9 15198.2 8521.2 8705.2 8709.5 8721.6 8753.3 6669.9 6926.0 6949.4 6961.5 6977.9 10218.3 13346.3 13408.7 13645.8 13673.0 10764.5 13110.7 13799.8 13800.5 13816.9 9391.0 9410.5 9512.7 9571.5 9628.2 10507.1 10628.6 10637.0 10639.3 10640.4 8686.7 8778.1 8878.7 9044.7 9192.5 8807.8 8870.9 8910.7 8991.2 9060.6 8072.8 8088.9 8126.5 8161.7 8189.5 5986.9 6035.2 6045.8 6082.8 6158.8 6069.0 6088.9 6091.0 6091.6 6112.8 05:18:25 INFO - PID 1645 | 05:18:25 INFO - PID 1645 | [#4] prototype.html Cycles:180 Average:5022.06 Median:5602.21 stddev:1510.86 (27.0%) stddev-sans-first:1473.91 05:18:25 INFO - PID 1645 | Values: 354.0 394.0 394.2 402.7 404.7 5282.3 5906.9 5923.7 5968.9 6033.2 4454.9 4635.4 5787.6 5828.9 5879.9 3630.5 4464.7 4477.8 4480.8 4490.9 3865.5 4273.8 4457.6 4470.4 4513.9 4272.7 4412.9 4446.6 4459.8 4471.9 3577.7 4404.7 4425.8 4429.6 4449.6 3256.0 3929.7 3936.6 3938.5 3958.9 4089.9 4309.5 5129.5 5687.3 5698.7 4632.3 5187.4 5270.4 5273.7 5304.1 5884.6 6157.3 6159.3 6180.4 6192.5 3623.9 4215.2 4491.9 4494.8 4502.2 5642.8 6125.1 6212.6 6373.7 6410.6 3517.3 4593.9 4598.5 4604.2 4619.8 3963.9 4656.2 4685.4 4690.5 4715.3 4734.3 4777.7 4964.2 5045.9 5343.4 5069.7 6127.7 6152.1 6172.0 6186.3 1560.4 1572.9 1601.8 1603.6 1611.5 1112.8 1121.5 1123.7 1125.8 1127.8 5851.2 5854.3 5924.0 5931.4 5933.9 5313.6 5480.5 5597.0 6439.5 6478.8 4775.9 5755.2 5786.6 5893.5 5908.4 2658.5 3298.5 3324.7 3332.5 3339.8 5607.4 6203.1 6329.7 6520.0 6577.0 5527.5 5832.9 6341.2 6449.9 6498.1 5436.3 5821.2 6196.6 6577.3 6599.6 5956.4 6391.7 6401.3 6411.6 6438.3 5323.1 5919.1 6056.9 6275.3 6284.4 5407.3 5412.8 6476.0 6578.4 6634.6 4343.3 4590.0 4590.2 4592.7 4611.6 5705.5 5761.3 6394.2 6407.7 6507.1 5873.6 6182.3 6190.2 6194.5 6222.3 5897.7 6165.4 6188.3 6215.6 6219.3 5963.8 6133.3 6155.2 6163.0 6175.8 6119.4 6285.7 6299.0 6300.4 6301.4 6067.4 6135.6 6150.9 6154.9 6171.4 05:18:25 INFO - PID 1645 | 05:18:25 INFO - PID 1645 | [#5] yui.html Cycles:180 Average:20986.48 Median:3404.58 stddev:29439.99 (864.7%) stddev-sans-first:29483.13 05:18:25 INFO - PID 1645 | Values: 690.9 841.7 842.6 851.2 861.3 12741.4 17648.2 17689.7 18150.5 18217.3 13992.2 16884.9 17066.0 17235.3 17310.9 934.0 963.2 964.3 965.7 969.9 651.1 669.9 937.7 966.4 973.1 984.3 984.9 985.4 989.3 1021.0 979.6 980.3 981.2 981.6 1018.8 718.0 724.7 725.1 735.0 760.1 15754.7 16073.8 16271.8 16498.0 16806.2 16185.7 16217.2 16615.3 16684.5 16947.8 11699.4 12760.7 13687.1 13928.4 14017.7 3395.4 3413.7 3415.9 3420.5 3422.2 117432.0 118822.0 119811.0 120000.0 121152.4 10655.8 10870.9 11464.3 11725.9 11770.6 13664.5 19394.9 25130.6 25143.1 25192.6 7657.2 7726.4 7836.8 7843.5 7848.5 3670.9 3722.3 3739.4 3749.6 3749.7 4138.4 4220.6 4283.6 4290.7 4293.2 901.7 934.1 936.1 937.8 939.6 609.4 616.6 616.9 624.3 658.3 9848.0 10379.3 10520.1 10646.8 10913.8 508.3 622.6 630.5 633.3 647.8 4069.5 4143.8 4716.2 4849.4 4939.0 85059.0 94366.0 105395.0 105417.0 110194.4 80700.8 82636.0 83400.0 86902.6 88794.0 68661.0 74139.0 75539.2 76709.6 77595.0 11858.9 12314.3 12368.3 12431.8 12610.7 30660.7 35566.3 35692.8 39858.8 40709.8 62605.0 64097.7 66639.7 69548.0 71920.6 16257.8 16303.3 16309.2 16446.3 16733.3 17827.5 17974.5 18456.9 18555.0 18560.9 15368.0 15594.2 15615.9 15659.0 15729.4 16285.7 16615.3 16771.4 16922.9 16933.7 13232.9 16301.5 16317.2 16491.0 16616.6 11748.4 11968.6 12044.6 12137.4 12197.9 11893.6 12028.4 12431.5 12540.0 12655.1 05:18:25 INFO - PID 1645 | -------- Summary: end -------- 05:18:25 INFO - PID 1645 | 05:18:26 INFO - TEST-INFO | 1645: exit 0 05:18:26 INFO - TEST-OK | dromaeo_css | took 1120848ms 05:18:26 INFO - TEST-START | kraken 05:18:26 INFO - operating with platform_type : mac_ 05:18:26 INFO - Initialising browser for kraken test... 05:18:26 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpfUkDuI/profile http://localhost:49243/getInfo.html) 05:18:29 INFO - PID 1653 | __metrics Screen width/height:1600/1200 05:18:29 INFO - PID 1653 | colorDepth:24 05:18:29 INFO - PID 1653 | Browser inner width/height: 1024/689 05:18:29 INFO - PID 1653 | __metrics 05:18:29 INFO - PID 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:18:29 INFO - PID 1653 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:18:30 INFO - TEST-INFO | 1653: exit 0 05:18:30 INFO - Browser initialized. 05:18:30 INFO - Running cycle 1/1 for kraken test... 05:18:30 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpfUkDuI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:42 INFO - PID 1654 | RSS: Main: 241131520 05:18:42 INFO - PID 1654 | 05:18:44 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 05:18:45 INFO - PID 1654 | RSS: Main: 311656448 05:18:45 INFO - PID 1654 | 05:18:48 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 05:18:49 INFO - PID 1654 | RSS: Main: 293425152 05:18:49 INFO - PID 1654 | 05:18:52 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 05:18:52 INFO - PID 1654 | RSS: Main: 385806336 05:18:52 INFO - PID 1654 | 05:18:54 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 05:18:55 INFO - PID 1654 | RSS: Main: 289034240 05:18:55 INFO - PID 1654 | 05:18:57 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:18:58 INFO - PID 1654 | RSS: Main: 293105664 05:18:58 INFO - PID 1654 | 05:19:01 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 05:19:01 INFO - PID 1654 | RSS: Main: 356167680 05:19:01 INFO - PID 1654 | 05:19:04 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 05:19:05 INFO - PID 1654 | RSS: Main: 372543488 05:19:05 INFO - PID 1654 | 05:19:08 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 05:19:08 INFO - PID 1654 | RSS: Main: 379195392 05:19:08 INFO - PID 1654 | 05:19:10 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:19:10 INFO - PID 1654 | RSS: Main: 333668352 05:19:10 INFO - PID 1654 | 05:19:12 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:19:13 INFO - PID 1654 | RSS: Main: 334479360 05:19:13 INFO - PID 1654 | 05:19:15 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:19:16 INFO - PID 1654 | RSS: Main: 318631936 05:19:16 INFO - PID 1654 | 05:19:19 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:19:19 INFO - PID 1654 | RSS: Main: 331784192 05:19:19 INFO - PID 1654 | 05:19:23 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:19:23 INFO - PID 1654 | RSS: Main: 342282240 05:19:23 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 05:19:25 INFO - PID 1654 | RSS: Main: 384851968 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | __start_tp_report 05:19:25 INFO - PID 1654 | _x_x_mozilla_page_load 05:19:25 INFO - PID 1654 | _x_x_mozilla_page_load_details 05:19:25 INFO - PID 1654 | |i|pagename|runs| 05:19:25 INFO - PID 1654 | |0;ai-astar;112;111;111;112;111;112;112;112;111;111 05:19:25 INFO - PID 1654 | |1;audio-beat-detection;138;111;111;151;112;109;106;110;137;109 05:19:25 INFO - PID 1654 | |2;audio-dft;189;184;184;186;185;186;185;185;184;185 05:19:25 INFO - PID 1654 | |3;audio-fft;79;59;59;87;59;57;56;56;82;62 05:19:25 INFO - PID 1654 | |4;audio-oscillator;91;75;112;101;98;74;89;64;69;89 05:19:25 INFO - PID 1654 | |5;imaging-gaussian-blur;89;89;88;88;89;88;89;88;88;89 05:19:25 INFO - PID 1654 | |6;imaging-darkroom;96;95;96;103;126;95;95;95;95;95 05:19:25 INFO - PID 1654 | |7;imaging-desaturate;87;85;84;83;83;83;83;84;84;84 05:19:25 INFO - PID 1654 | |8;json-parse-financial;49;48;49;49;49;50;48;48;47;65 05:19:25 INFO - PID 1654 | |9;json-stringify-tinderbox;56;63;57;77;96;84;57;57;59;58 05:19:25 INFO - PID 1654 | |10;stanford-crypto-aes;82;82;83;83;82;86;83;82;83;81 05:19:25 INFO - PID 1654 | |11;stanford-crypto-ccm;139;138;134;151;150;147;139;140;219;126 05:19:25 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;186;184;182;185;182;183;182;221;187;181 05:19:25 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;68;68;68;66;65;67;68;68;67;67 05:19:25 INFO - PID 1654 | __end_tp_report 05:19:25 INFO - PID 1654 | __start_cc_report 05:19:25 INFO - PID 1654 | _x_x_mozilla_cycle_collect,2199 05:19:25 INFO - PID 1654 | __end_cc_report 05:19:25 INFO - PID 1654 | __startTimestamp1492604365675__endTimestamp 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | ------- Summary: start ------- 05:19:25 INFO - PID 1654 | Number of tests: 14 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:19:25 INFO - PID 1654 | Values: 112.0 111.0 111.0 112.0 111.0 112.0 112.0 112.0 111.0 111.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:119.40 Median:111.50 stddev:16.11 (14.4%) stddev-sans-first:15.61 05:19:25 INFO - PID 1654 | Values: 138.0 111.0 111.0 151.0 112.0 109.0 106.0 110.0 137.0 109.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:185.30 Median:185.00 stddev:1.49 (0.8%) stddev-sans-first:0.78 05:19:25 INFO - PID 1654 | Values: 189.0 184.0 184.0 186.0 185.0 186.0 185.0 185.0 184.0 185.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.50 stddev:12.06 (19.9%) stddev-sans-first:11.77 05:19:25 INFO - PID 1654 | Values: 79.0 59.0 59.0 87.0 59.0 57.0 56.0 56.0 82.0 62.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:86.20 Median:82.00 stddev:15.37 (18.7%) stddev-sans-first:16.20 05:19:25 INFO - PID 1654 | Values: 91.0 75.0 112.0 101.0 98.0 74.0 89.0 64.0 69.0 89.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:19:25 INFO - PID 1654 | Values: 89.0 89.0 88.0 88.0 89.0 88.0 89.0 88.0 88.0 89.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:99.10 Median:95.00 stddev:9.77 (10.3%) stddev-sans-first:10.30 05:19:25 INFO - PID 1654 | Values: 96.0 95.0 96.0 103.0 126.0 95.0 95.0 95.0 95.0 95.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:1.25 (1.5%) stddev-sans-first:0.71 05:19:25 INFO - PID 1654 | Values: 87.0 85.0 84.0 83.0 83.0 83.0 83.0 84.0 84.0 84.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:49.00 stddev:5.27 (10.7%) stddev-sans-first:5.57 05:19:25 INFO - PID 1654 | Values: 49.0 48.0 49.0 49.0 49.0 50.0 48.0 48.0 47.0 65.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:61.00 stddev:14.18 (23.2%) stddev-sans-first:14.53 05:19:25 INFO - PID 1654 | Values: 56.0 63.0 57.0 77.0 96.0 84.0 57.0 57.0 59.0 58.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.34 (1.6%) stddev-sans-first:1.39 05:19:25 INFO - PID 1654 | Values: 82.0 82.0 83.0 83.0 82.0 86.0 83.0 82.0 83.0 81.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:143.50 stddev:25.95 (18.1%) stddev-sans-first:27.30 05:19:25 INFO - PID 1654 | Values: 139.0 138.0 134.0 151.0 150.0 147.0 139.0 140.0 219.0 126.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.30 Median:184.50 stddev:12.00 (6.5%) stddev-sans-first:12.72 05:19:25 INFO - PID 1654 | Values: 186.0 184.0 182.0 185.0 182.0 183.0 182.0 221.0 187.0 181.0 05:19:25 INFO - PID 1654 | 05:19:25 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 05:19:25 INFO - PID 1654 | Values: 68.0 68.0 68.0 66.0 65.0 67.0 68.0 68.0 67.0 67.0 05:19:25 INFO - PID 1654 | -------- Summary: end -------- 05:19:25 INFO - PID 1654 | 05:19:26 INFO - TEST-INFO | 1654: exit 0 05:19:27 INFO - TEST-OK | kraken | took 60591ms 05:19:27 INFO - SUITE-END | took 1181s 05:19:27 INFO - Completed test suite (00:19:41) 05:19:27 INFO - javascript benchmark 05:19:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7642.162353381175, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3490.319387719394, 3495.5980062292842, 3514.086337552236, 3529.9294014119732, 3540.876069337572, 5813.30240371155, 5938.10928360745, 6182.196314479117, 6220.6267623942485, 6240.719167637456, 5969.671668058255, 6004.759809607622, 6018.277806663195, 6024.819255422333, 6029.366916473773, 4391.890202744925, 5223.869403264911, 5253.080710875582, 5287.233351164079, 5319.042572336978, 5356.4107948125675, 5420.1327787554, 5435.130379139338, 5442.591805614575, 5488.451154884519, 5414.620976531624, 5417.891642167155, 5420.403755586883, 5438.075527160372, 5441.891162176754, 5136.43499215086, 5284.260203571503, 5411.945880541223, 5415.864603384927, 5494.890102197934, 5315.734213289359, 5331.973340133313, 5342.893142137174, 5382.111951527993, 5396.082665946798, 6063.242094738158, 6115.235595550556, 6143.78496752616, 6151.108089327023, 6160.0, 6350.745970161188, 6441.645709485976, 6459.903101453482, 6484.221893372825, 6488.0916671666, 6146.016637338004, 6370.4266616004315, 6493.675316234217, 6549.770758023494, 6559.2128944526485, 6225.315215326311, 6241.126242326078, 6248.062790581358, 6257.311695713468, 6260.060990851318, 6689.297623749533, 6726.327367263235, 6735.797926062226, 6742.426893713991, 6742.49431292655, 6264.812055638247, 6289.937100629027, 6360.459360954278, 6373.330800265998, 6393.6163830170335, 6533.477321814244, 6543.705533251015, 6554.279029306867, 6572.704228309737, 6589.110470086573, 6289.276733175652, 6341.143945567382, 6420.6147631142285, 6429.7749578764515, 6431.42117209444, 6372.490200783926, 6411.358864113645, 6411.839704007344, 6420.454261387741, 6455.064015717695, 5249.553787928069, 5276.788928442896, 5292.391374991848, 5316.787328506816, 5320.600954928396, 4561.794719237642, 4706.152892479318, 4718.834840780556, 4723.385959825269, 4759.571638552547, 6079.179310792986, 6087.391260873877, 6105.572609917263, 6105.938940610537, 6107.450329470369, 6357.841053973595, 6358.554901156967, 6384.265809431975, 6384.52116091295, 6388.0, 5023.8492845214705, 5094.541491265803, 6045.637261764308, 6074.696265186723, 6097.908531372033, 5591.161325801162, 5670.773169073191, 5672.886542269214, 5674.659520428788, 5678.0, 6538.640374779433, 6542.869142617121, 6689.698963546554, 6740.730370785113, 6770.593764374154, 6542.54202205841, 6575.80272591823, 6590.7693230736695, 6594.142761440982, 6596.241432235354, 6778.254392016973, 6787.0, 6811.352921472452, 6820.283870193558, 6836.008778727156, 6301.495880329471, 6374.872502549831, 6418.293987661447, 6432.35676432353, 6446.226452825691, 6478.481721462177, 6509.446697030806, 6522.608643481406, 6528.738850445929, 6538.248101468392, 5067.5185857343495, 5964.731587078505, 6349.6507692077375, 6352.68236588178, 6365.2361716594305, 6293.590916590407, 6338.429541341301, 6339.746410143543, 6340.112384266298, 6381.489480841615, 6129.84675383119, 6130.540209484396, 6165.414285642857, 6169.167162433014, 6182.165407670087, 6295.527835412454, 6300.2754683212015, 6307.90538141919, 6324.304326523987, 6331.873362532631, 6133.946794548555, 6183.103449999815, 6256.0, 6314.463270622048, 6363.0], "value": 5947.069247969851, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.7594283743458, 805.5891495337378, 1103.9337639741616, 1116.8324751287312, 1123.561810893751, 31423.21441963949, 31962.721491140357, 34375.82812085939, 34987.4751878722, 34992.82503587485, 28319.0, 37159.4426083609, 37593.81203093981, 37656.81171594138, 37666.0, 5912.674802885839, 6025.638461692291, 8139.0, 8283.420160588761, 8288.668453261862, 5881.558883083786, 5993.46058854703, 5997.190379298782, 8129.512229266263, 8275.08974012858, 8354.24811766941, 8354.331653467709, 8360.749177524654, 8364.498130112182, 8370.33037357013, 8279.296259817893, 8338.999999999969, 8346.707865224687, 8355.874661880076, 8398.580070996426, 8158.184181581853, 8210.794730131794, 8211.05572859123, 8211.876821847676, 8217.383696222807, 35618.753343632845, 35667.28665426703, 35720.46419303712, 35764.0, 35794.64205357965, 3534.7525673202886, 3555.0, 3558.1460449492192, 3561.5904171020147, 3563.679268865789, 29006.12981610534, 29118.27204319888, 29169.979050733124, 29184.562231566542, 29191.85404072987, 3079.3687294104657, 3099.0547882895708, 3139.199504126456, 3145.072203699914, 3151.8108913465267, 200721.0, 267279.0, 268977.0, 269589.0, 270253.0, 37752.0, 38178.045548860944, 38281.0, 45762.77118614386, 45962.31056534155, 48119.51880481221, 48469.27296090561, 48664.51335486671, 48817.75591122093, 48818.75590622024, 13270.535531256359, 13339.132956357806, 13360.33198340079, 13381.66545836362, 13382.13016153947, 10922.399268040175, 10925.726856828644, 10934.781304373868, 10950.178736594788, 10962.506687199095, 11677.91273054441, 11681.88318116825, 11683.0, 11707.707307317214, 11805.527778888749, 4058.330375488011, 4732.858014259577, 5169.71566563835, 5177.326947496801, 5188.351456067991, 996.3573495095623, 1008.1531513528671, 1036.7667274863247, 1037.4968140451874, 1057.603398725478, 23702.05191792309, 23719.288421347388, 23778.929948152374, 23802.404939876295, 24133.637995430083, 1085.3813326403874, 1093.8359246113146, 1128.960486382989, 1137.0960086731068, 1152.262551966742, 11582.247153934968, 12203.694907627203, 12205.69485762863, 12206.389680515938, 12261.325627090595, 300695.496522516, 301839.0, 302469.0, 302559.0, 303116.4844175809, 50680.746596266785, 50699.746501267255, 50735.746321268896, 50803.23795143076, 50932.72668183325, 1474.2260313335585, 1518.301581272627, 1528.5414375687471, 1535.2477286129715, 1542.3830467812966, 23382.298531044096, 23512.764872351057, 23533.529329413657, 23638.409039774142, 23767.405814854767, 36391.09022274464, 36443.0, 36451.0, 36571.634283657884, 36573.817130914176, 278664.0, 278766.0, 279151.0, 279365.0, 279398.0, 28025.71974280231, 28153.31218362459, 31305.53041704331, 32960.83519582387, 33135.0, 40313.59686403099, 41063.1787364257, 41140.0, 41145.148468319596, 41212.793936030124, 27943.580846286914, 28101.859490702416, 29573.408531828813, 30391.544126837674, 30473.847630761706, 27866.30334241579, 29317.973870914415, 29512.409751804415, 29925.401491970475, 30321.24196895095, 36450.45324320084, 36526.817365913, 36614.0, 36619.81690091533, 36645.0, 25833.870830645727, 28408.00571979971, 28776.85611571929, 29569.85215073911, 30384.26098866891, 22056.779432206113, 23230.0, 23318.766812331658, 23490.64764028575, 23915.641265381382], "value": 16587.214099796234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.2135039159411, 429.6262251840899, 432.37305906435654, 441.3996964128784, 456.44580204403997, 18236.544086397847, 18612.883227006354, 20663.483412914666, 21434.464138396528, 21493.03281352339, 21443.785562144374, 22076.88961555194, 22323.776762232374, 22748.886255568697, 22766.0, 5964.642121472714, 6209.348018458065, 6238.844028899269, 6239.095331176976, 6241.531885108612, 5959.195508606326, 6038.033914573669, 6045.214122164134, 6133.723982420779, 6135.3557876423, 6025.668588227646, 6090.360512146227, 6092.390760923894, 6109.511239100883, 6137.079438084301, 6010.939890601104, 6129.1419201311855, 6192.628442293431, 6205.131281620576, 6207.441330280274, 5261.710605916673, 5406.135018397077, 5456.727163641842, 5477.917831232495, 5489.615726899118, 27411.86294068537, 27748.30629234265, 27840.30399240015, 27930.3017424564, 27933.0, 2147.3879944215823, 2210.2816584609905, 2210.701555290031, 2215.8670479771267, 2217.0577504560497, 17842.0, 17916.372926947624, 17936.641267174713, 18154.18306176225, 18416.0, 1894.6873765828623, 2145.626798848738, 2164.1343462614923, 2200.185931205448, 2211.3587059752654, 162846.0, 164094.17952910278, 166171.0, 166690.0, 167706.1614691931, 12076.396180190955, 12088.939555302168, 12287.324197169062, 12308.938455307667, 12544.874551254554, 16624.750628740338, 16629.251683674265, 16640.0, 16662.250198741087, 16758.497245082668, 8756.8686469703, 8812.427192232484, 8880.289576833839, 8970.237529809909, 8983.910160898307, 8272.627731751965, 8290.129536398712, 8297.792555186168, 8464.111268316861, 8465.534395608178, 7720.498167619086, 7866.410019248465, 7867.449278550561, 7889.0, 7922.643481043367, 1817.2367605605677, 2053.712480252766, 2070.0477780221267, 2144.538924131319, 2150.139944022372, 953.6471505542994, 960.3661583354952, 986.7434467038478, 997.6159178716247, 998.0867506231862, 19896.801031989784, 21352.039158237916, 21363.03866326019, 21530.0654891843, 21626.35120946374, 960.279790157382, 963.8843338799389, 1002.904724051214, 1005.7435353984833, 1011.2112552209142, 9082.22801061904, 10565.577376904837, 10902.618408355669, 10907.509162087725, 11011.559537618405, 517895.0, 528849.0, 529730.0, 558315.0, 559913.0, 132823.0, 136787.0, 136995.0, 141494.0, 143968.0, 1158.0921446938592, 1173.049829637996, 1196.4795314038422, 1197.694587880085, 1200.2858299311895, 17141.228644711267, 18048.0, 18080.457586272434, 18167.45497635073, 18640.627187456445, 54934.72532637311, 56856.71571642115, 59374.81250374882, 59458.405415945286, 59501.70249148727, 73873.0, 75130.0, 75133.62433187799, 75804.62097689476, 76194.23805762093, 8516.361272904682, 8604.956975215335, 8752.69365572202, 9058.818823623622, 9235.445873247627, 12048.819267711167, 13728.382222799799, 14100.858991409954, 14115.505957291856, 14562.927185364006, 9620.619722221023, 11722.062235021349, 11870.525178992744, 12044.277343359427, 12141.08941829384, 11200.775984480102, 11217.551297948317, 11298.308280001918, 11654.70863228426, 11669.183157178915, 11312.03847672957, 11603.795278896983, 11936.16446848747, 11950.760984780081, 12127.878721212675, 7281.708731650675, 8848.601812918563, 8945.016048234558, 8971.641134354553, 9065.637374504946, 11805.0, 11866.584669536525, 12104.334261615695, 12132.636020919386, 12161.574344897886], "value": 10398.596211581205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1159.153817713069, 1229.4098832560371, 1348.5819395987244, 1397.8881689464845, 1420.1975883625757, 9465.621375144994, 9805.607775688974, 11488.483018264178, 11543.191976561644, 11550.884491155086, 9472.715818525437, 11076.944615276912, 11250.66248012559, 11265.662030139089, 11268.549258029689, 2465.8890349934204, 2507.6489291499206, 2509.510645424143, 2513.1329691256487, 2515.132279363617, 2106.2101711858054, 2179.8801065941366, 2180.661997390399, 2181.5418762059985, 2181.858179218346, 2135.0712440088532, 2429.0890915906534, 2499.0378704198924, 2501.6122501012374, 2510.272021113875, 2474.715407728116, 2503.824732268742, 2505.799536037113, 2509.2221411362534, 2510.63595778612, 2091.351680978901, 2166.815820655246, 2300.6894069300597, 2421.7093948726265, 2467.037855236459, 11397.601083962105, 11466.770664586662, 11473.541058357656, 11498.022668073223, 11506.021988130935, 6364.745410183587, 6608.735650573972, 6622.139121914121, 6625.337466253336, 6629.403353698142, 3978.7214894957365, 4173.24881521326, 4350.456192975878, 4359.803808828578, 4360.476742790854, 1123.3933675815051, 1230.5323976888726, 1266.2149467330314, 1272.6054922973908, 1273.4460509678227, 16114.033158010558, 16123.838761612351, 16141.677166456606, 16168.0, 16171.83828161715, 5686.886262274814, 5859.296884373817, 5861.824145275648, 5907.586468947133, 5977.940220597825, 13490.595282141552, 13510.594682159355, 13519.391627376595, 13531.797023044466, 13532.188068715908, 6593.2088149421415, 6688.598684078971, 6711.563748356439, 6717.5297729159465, 6724.9327506725285, 5147.382314122329, 5987.221661184019, 6137.0794380842335, 6172.969135154385, 6184.474319682878, 4060.309747342959, 4349.803349308579, 4467.12890986261, 4502.167099086614, 4525.162844873643, 1287.8969682425384, 1300.3343146549723, 1300.3472915252778, 1302.218668798732, 1303.139927647748, 627.7991042866239, 639.7014061455253, 695.4262733245093, 727.5780047572396, 781.2343902975116, 6524.7390104396245, 6735.090762747064, 6896.310368963063, 6958.619594138401, 6961.82595435108, 847.682119205298, 904.3895370624801, 914.410205417502, 925.1627277314042, 929.0848514213494, 3601.2797440512004, 3771.151490914522, 4122.175564887035, 4267.25323068468, 4295.334223195409, 14364.784528232085, 15104.54686359411, 15105.169215693022, 15106.942514023913, 15212.695746085237, 14304.427822886968, 14851.405943762129, 15018.69962600742, 15033.924830375998, 15198.16410097433, 8521.233089022018, 8705.173008564303, 8709.477431354138, 8721.60752766127, 8753.343499237582, 6669.932320980512, 6925.965370173117, 6949.3745562899585, 6961.503276795514, 6977.860442791217, 10218.284720069523, 13346.332683365987, 13408.731825363633, 13645.795313070113, 13673.042886997815, 10764.461776910966, 13110.737785244433, 13799.79300310476, 13800.516981905585, 13816.8946484279, 9390.95304523473, 9410.482423466776, 9512.714618561455, 9571.521423928914, 9628.18160456369, 10507.106895913934, 10628.574857005633, 10636.989485998818, 10639.308444951053, 10640.414777187329, 8686.695965641173, 8778.122187781171, 8878.73363799087, 9044.728658140266, 9192.49441280736, 8807.823843523222, 8870.866936996079, 8910.724033546825, 8991.23574496149, 9060.592273347847, 8072.838543228985, 8088.919110809052, 8126.471779334324, 8161.714339998071, 8189.50862948225, 5986.910196347146, 6035.215421995113, 6045.848853778691, 6082.847928801815, 6158.753649853956, 6068.9655172413795, 6088.908666369919, 6091.0, 6091.573589848846, 6112.847178820387], "value": 5303.7047393870835, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.97877124495824, 393.9881803545895, 394.23715111259713, 402.72738147454044, 404.66210714053744, 5282.286891269678, 5906.911396329058, 5923.73343199556, 5968.910466343008, 6033.245844269466, 4454.933626238785, 4635.443746750386, 5787.565932555065, 5828.912566311508, 5879.911801322984, 3630.49173115764, 4464.665150113755, 4477.776111194444, 4480.798364073625, 4490.865274041784, 3865.4781604483314, 4273.764942928137, 4457.643388528926, 4470.368315564811, 4513.887152821173, 4272.743635381887, 4412.867613971586, 4446.577575130357, 4459.754713490756, 4471.8658440246845, 3577.7316701247382, 4404.66964977628, 4425.8229670813125, 4429.557044295577, 4449.644028477714, 3255.967440325614, 3929.7052721046034, 3936.6457018868155, 3938.5273767147837, 3958.9318278334235, 4089.85685501009, 4309.526900835921, 5129.461406552296, 5687.289088863892, 5698.743556539925, 4632.3051542268595, 5187.351581052369, 5270.367555893279, 5273.683578985235, 5304.09052741013, 5884.558658100616, 6157.322694503601, 6159.291681456601, 6180.412860778219, 6192.504599632019, 3623.8912832615065, 4215.241256573816, 4491.910161796745, 4494.775261236958, 4502.167099086647, 5642.802501912454, 6125.111858780452, 6212.596181248205, 6373.713182906734, 6410.615363078184, 3517.296540691872, 4593.908121837611, 4598.540145985375, 4604.194266003436, 4619.815207391666, 3963.8810835674976, 4656.1608164774725, 4685.367475390847, 4690.530946905282, 4715.269133284346, 4734.26618874075, 4777.700069937015, 4964.205727083649, 5045.949540504622, 5343.385510666245, 5069.746512674352, 6127.724252408652, 6152.107944348134, 6171.9691401542705, 6186.288576813634, 1560.39144733554, 1572.8505791949747, 1601.7917670702966, 1603.5510057184008, 1611.5004348651955, 1112.8275117356823, 1121.5233525751687, 1123.719070232442, 1125.780472807811, 1127.768807394482, 5851.210086638334, 5854.326752423441, 5923.970380148158, 5931.40685931412, 5933.902228087818, 5313.601479888946, 5480.479354461399, 5597.0, 6439.454530912547, 6478.838029049217, 4775.928361074587, 5755.194272801811, 5786.594938354359, 5893.499052580579, 5908.438698323653, 2658.4550167215675, 3298.472244440926, 3324.6509116542898, 3332.5167850662, 3339.7662163648797, 5607.4112218217315, 6203.100550420254, 6329.715162817684, 6519.967400162969, 6577.0, 5527.50252477279, 5832.8541786454825, 6341.207349081365, 6449.936280266836, 6498.090267362573, 5436.293281873332, 5821.243238378984, 6196.566240363221, 6577.3422657733845, 6599.571027883172, 5956.374580668968, 6391.744330226925, 6401.327860574573, 6411.615303081643, 6438.259600146043, 5323.1216849219445, 5919.076300202365, 6056.939430605637, 6275.278342990432, 6284.402981716729, 5407.297051383295, 5412.8105516308315, 6476.017249391684, 6578.407943285128, 6634.635095069624, 4343.283358245981, 4589.977050114728, 4590.173768721662, 4592.7014744041535, 4611.61651504554, 5705.486506214461, 5761.308642962871, 6394.23269207698, 6407.743690252524, 6507.12153859223, 5873.5594830388745, 6182.28903676083, 6190.1952746142715, 6194.535409844189, 6222.284437289589, 5897.67562784051, 6165.352637972948, 6188.257409110935, 6215.564910456224, 6219.314237194943, 5963.7912673056235, 6133.338662616533, 6155.199824023028, 6162.969185154046, 6175.814725558241, 6119.44924956756, 6285.748570057147, 6298.968505157445, 6300.369963003663, 6301.368494156883, 6067.393260673897, 6135.631862088289, 6150.907736384047, 6154.907676384768, 6171.444569988723], "value": 4570.965157617796, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.8825499665056, 841.688575227166, 842.5913431985485, 851.2041241439255, 861.3023451004686, 12741.362931853406, 17648.205830737614, 17689.734653980202, 18150.546236344097, 18217.27130914765, 13992.160470371784, 16884.915575422136, 17065.976041437523, 17235.310587576514, 17310.913445432754, 933.9813203735938, 963.210167662517, 964.28642804325, 965.6620182935986, 969.883613966325, 651.1469974333638, 669.9062131301622, 937.7139972308444, 966.4153187321674, 973.0512750068697, 984.3355734878963, 984.8965858584853, 985.3545927417517, 989.3223142147652, 1020.9897901020969, 979.5543027922279, 980.3039841712392, 981.1562056631292, 981.6318880419842, 1018.8064267789097, 717.9676914538807, 724.7028718225503, 725.1298441869777, 734.977950661481, 760.1068744225513, 15754.684906301809, 16073.758893616605, 16271.755923661154, 16498.010119392875, 16806.15969201535, 16185.676286474205, 16217.189140542925, 16615.335386584524, 16684.49946501607, 16947.83052169475, 11699.415029248588, 12760.744785104338, 13687.11033782801, 13928.442862285496, 14017.71964560703, 3395.439752440844, 3413.7269018478464, 3415.863365465403, 3420.538227339302, 3422.247105636781, 117432.0, 118822.0, 119811.0, 120000.0, 121152.39423802913, 10655.84016239757, 10870.94564527188, 11464.31214127155, 11725.882741172649, 11770.646880593597, 13664.521741738992, 19394.903025484782, 25130.623040654405, 25143.119990800235, 25192.622110668355, 7657.157712651604, 7726.420518461138, 7836.764897053097, 7843.490173138728, 7848.489848159851, 3670.8898733037518, 3722.3299806034634, 3739.439084137401, 3749.5500539935383, 3749.681277091423, 4138.399932009842, 4220.599043090901, 4283.635890949242, 4290.742555446684, 4293.248681480728, 901.6934242357498, 934.065934065934, 936.0873148679982, 937.7655586103474, 939.6382392778829, 609.3662590905409, 616.6033933141438, 616.8735409241184, 624.2696045626537, 658.2627457247913, 9847.950760246153, 10379.273450858518, 10520.10579100785, 10646.787064258671, 10913.83629245562, 508.28332051806774, 622.5673157155824, 630.549157352486, 633.2907143998659, 647.7829926974422, 4069.4709687740406, 4143.834246630161, 4716.198246298138, 4849.369581954394, 4938.950610493921, 85059.0, 94366.0, 105395.0, 105417.0, 110194.44902775595, 80700.78948815772, 82636.0, 83400.0, 86902.56548717216, 88794.0, 68661.0, 74139.0, 75539.24460755433, 76709.6164519185, 77595.0, 11858.881411186123, 12314.322712250912, 12368.319742414255, 12431.75136497247, 12610.684732881384, 30660.693393066675, 35566.28867422689, 35692.82153589215, 39858.800705996284, 40709.79645101756, 62605.0, 64097.679511602146, 66639.66680166568, 69548.0, 71920.64039679768, 16257.75613365824, 16303.347866085223, 16309.18454077315, 16446.34214631449, 16733.330666773192, 17827.465176044738, 17974.460766177035, 18456.907715461875, 18554.97947612894, 18560.907195463937, 15368.001079929769, 15594.220288985278, 15615.921920390325, 15659.0, 15729.370825166865, 16285.674286513966, 16615.3353865844, 16771.413000544922, 16922.900011499212, 16933.745993809855, 13232.867671323163, 16301.51095467138, 16317.18414079315, 16491.0, 16616.584585385463, 11748.353840538852, 11968.640940771791, 12044.638660840188, 12137.393130343624, 12197.878021219674, 11893.643190704293, 12028.398580071136, 12431.502739890664, 12539.996800255774, 12655.11414200997], "value": 8009.9174348635115, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1441.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 111.0, 112.0, 111.0, 112.0, 112.0, 112.0, 111.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 111.0, 111.0, 151.0, 112.0, 109.0, 106.0, 110.0, 137.0, 109.0], "value": 119.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 184.0, 184.0, 186.0, 185.0, 186.0, 185.0, 185.0, 184.0, 185.0], "value": 185.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 87.0, 59.0, 57.0, 56.0, 56.0, 82.0, 62.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 75.0, 112.0, 101.0, 98.0, 74.0, 89.0, 64.0, 69.0, 89.0], "value": 86.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 88.0, 89.0, 88.0, 89.0, 88.0, 88.0, 89.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 103.0, 126.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 99.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 84.0, 83.0, 83.0, 83.0, 83.0, 84.0, 84.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 49.0, 49.0, 49.0, 50.0, 48.0, 48.0, 47.0, 65.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 63.0, 57.0, 77.0, 96.0, 84.0, 57.0, 57.0, 59.0, 58.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 83.0, 82.0, 86.0, 83.0, 82.0, 83.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 134.0, 151.0, 150.0, 147.0, 139.0, 140.0, 219.0, 126.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 182.0, 185.0, 182.0, 183.0, 182.0, 221.0, 187.0, 181.0], "value": 187.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 66.0, 65.0, 67.0, 68.0, 68.0, 67.0, 67.0], "value": 67.2, "unit": "score"}]}]} 05:19:27 INFO - Return code: 0 05:19:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:19:27 ERROR - # TBPL SUCCESS # 05:19:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:19:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:19:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:19:27 INFO - 2017-04-19 05:19:27.492 screenresolution[1659:9868] starting screenresolution argv=screenresolution get 05:19:27 INFO - 2017-04-19 05:19:27.495 screenresolution[1659:9868] Display 0: 1600x1200x32@60 05:19:27 INFO - 2017-04-19 05:19:27.501 screenresolution[1660:9871] starting screenresolution argv=screenresolution list 05:19:27 INFO - Available Modes on Display 0 05:19:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:19:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:19:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:19:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:19:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:19:27 INFO - Intel Iris: 05:19:27 INFO - Chipset Model: Intel Iris 05:19:27 INFO - Type: GPU 05:19:27 INFO - Bus: Built-In 05:19:27 INFO - VRAM (Dynamic, Max): 1536 MB 05:19:27 INFO - Vendor: Intel (0x8086) 05:19:27 INFO - Device ID: 0x0a2e 05:19:27 INFO - Revision ID: 0x0009 05:19:27 INFO - Displays: 05:19:27 INFO - Display: 05:19:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:19:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:19:27 INFO - Display Serial Number: 1600x1200 60 05:19:27 INFO - Main Display: Yes 05:19:27 INFO - Mirror: Off 05:19:27 INFO - Online: Yes 05:19:27 INFO - Rotation: Supported 05:19:27 INFO - Return code: 0 05:19:27 INFO - Running post-action listener: _resource_record_post_action 05:19:27 INFO - [mozharness: 2017-04-19 12:19:27.744770Z] Finished run-tests step (success) 05:19:27 INFO - Running post-run listener: _resource_record_post_run 05:19:27 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 47851008; Write bytes: 515161088; Read time: 520; Write time: 1721 05:19:27 INFO - TinderboxPrint: CPU usage
53.2% 05:19:27 INFO - TinderboxPrint: I/O read bytes / time
47,851,008 / 520 05:19:27 INFO - TinderboxPrint: I/O write bytes / time
515,161,088 / 1,721 05:19:27 INFO - TinderboxPrint: CPU idle
2,251.2 (46.8%) 05:19:27 INFO - TinderboxPrint: CPU system
953.6 (19.8%) 05:19:27 INFO - TinderboxPrint: CPU user
1,604.8 (33.4%) 05:19:27 INFO - TinderboxPrint: Swap in / out
247,230,464 / 0 05:19:27 INFO - install - Wall time: 20s; CPU: 55.0%; Read bytes: 212834816; Write bytes: 204294144; Read time: 16019; Write time: 417 05:19:27 INFO - run-tests - Wall time: 1183s; CPU: 53.0%; Read bytes: 40345088; Write bytes: 303813632; Read time: 428; Write time: 1275 05:19:28 INFO - Running post-run listener: _upload_blobber_files 05:19:28 INFO - Blob upload gear active. 05:19:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:19:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:19:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:19:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:19:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:19:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:29 INFO - (blobuploader) - INFO - Done attempting. 05:19:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:19:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:19:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:30 INFO - (blobuploader) - INFO - Done attempting. 05:19:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:19:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:32 INFO - (blobuploader) - INFO - Done attempting. 05:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:19:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:34 INFO - (blobuploader) - INFO - Done attempting. 05:19:34 INFO - (blobuploader) - INFO - Iteration through files over. 05:19:34 INFO - Return code: 0 05:19:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:19:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:19:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/642de06bc49d7090c48e88619f03b8c85c2e82abb14854982362f8fffb597e0a46187d75cd023939e626103e02d58a3d7c873405e44a3a0f6482e422300e06e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72086e5375c2639633561751bab2b3880efab1e6fa03543bfbe359c80a95ee4a28cb0c2a8e4dce20413d0c981c89ce3df855f44f37cc2a31c90226ace0dc0f2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed90aa5c934817348984bcdd073bcd934dd0f518af60c029135426dddff8ab6caf5d56e08906e90d4e9d0b0c5600cbb4318e61528d8e407b385fe5278e25bf16", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a2e7f22bab330481e4c0447e86e4d43336ee629dd403f09c54441e011b474779c9989c74d6365a825e5e3e76f3cbf096f3ccf7c82cae05312f7c725c0a8a36d"} 05:19:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:19:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:19:34 INFO - Contents: 05:19:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/642de06bc49d7090c48e88619f03b8c85c2e82abb14854982362f8fffb597e0a46187d75cd023939e626103e02d58a3d7c873405e44a3a0f6482e422300e06e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72086e5375c2639633561751bab2b3880efab1e6fa03543bfbe359c80a95ee4a28cb0c2a8e4dce20413d0c981c89ce3df855f44f37cc2a31c90226ace0dc0f2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed90aa5c934817348984bcdd073bcd934dd0f518af60c029135426dddff8ab6caf5d56e08906e90d4e9d0b0c5600cbb4318e61528d8e407b385fe5278e25bf16", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a2e7f22bab330481e4c0447e86e4d43336ee629dd403f09c54441e011b474779c9989c74d6365a825e5e3e76f3cbf096f3ccf7c82cae05312f7c725c0a8a36d"} 05:19:34 INFO - Running post-run listener: copy_logs_to_upload_dir 05:19:34 INFO - Copying logs to upload dir... 05:19:34 INFO - mkdir: /builds/slave/test/build/upload/logs 05:19:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1300.266418 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2017-04-19 05:19:34.372640) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 05:19:34.375688) ========= 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.ypHf3kmtML/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.zk24HIRC9L/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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/642de06bc49d7090c48e88619f03b8c85c2e82abb14854982362f8fffb597e0a46187d75cd023939e626103e02d58a3d7c873405e44a3a0f6482e422300e06e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72086e5375c2639633561751bab2b3880efab1e6fa03543bfbe359c80a95ee4a28cb0c2a8e4dce20413d0c981c89ce3df855f44f37cc2a31c90226ace0dc0f2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed90aa5c934817348984bcdd073bcd934dd0f518af60c029135426dddff8ab6caf5d56e08906e90d4e9d0b0c5600cbb4318e61528d8e407b385fe5278e25bf16", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a2e7f22bab330481e4c0447e86e4d43336ee629dd403f09c54441e011b474779c9989c74d6365a825e5e3e76f3cbf096f3ccf7c82cae05312f7c725c0a8a36d"} build_url:https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/642de06bc49d7090c48e88619f03b8c85c2e82abb14854982362f8fffb597e0a46187d75cd023939e626103e02d58a3d7c873405e44a3a0f6482e422300e06e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72086e5375c2639633561751bab2b3880efab1e6fa03543bfbe359c80a95ee4a28cb0c2a8e4dce20413d0c981c89ce3df855f44f37cc2a31c90226ace0dc0f2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed90aa5c934817348984bcdd073bcd934dd0f518af60c029135426dddff8ab6caf5d56e08906e90d4e9d0b0c5600cbb4318e61528d8e407b385fe5278e25bf16", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a2e7f22bab330481e4c0447e86e4d43336ee629dd403f09c54441e011b474779c9989c74d6365a825e5e3e76f3cbf096f3ccf7c82cae05312f7c725c0a8a36d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 05:19:34.410910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 05:19:34.411233) ========= 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.ypHf3kmtML/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.zk24HIRC9L/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.005028 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 05:19:34.463197) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 05:19:34.466563) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 05:19:34.466906) ========= ========= Total master_lag: 1.27 =========