builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0240 starttime: 1491737083.73 results: success (0) buildid: 20170409030205 builduid: a2978479d2784793a733df1f4bc1626b revision: 2a3ecdb7d1ea814708021fee6735b3aedcf03e48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 04:24:43.731149) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 04:24:43.731595) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 04:24:43.731890) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 04:24:43.919419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:24:43.919830) ========= 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.wAIyCm0afI/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.sKFJqTORhf/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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-09 04:24:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 181M=0s 2017-04-09 04:24:44 (181 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.555452 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:24:44.502546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:24:44.502881) ========= 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.wAIyCm0afI/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.sKFJqTORhf/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.030503 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:24:44.556741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-09 04:24:44.557207) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a3ecdb7d1ea814708021fee6735b3aedcf03e48 --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 2a3ecdb7d1ea814708021fee6735b3aedcf03e48 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wAIyCm0afI/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.sKFJqTORhf/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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-09 04:24:44,670 truncating revision to first 12 chars 2017-04-09 04:24:44,670 Setting DEBUG logging. 2017-04-09 04:24:44,670 attempt 1/10 2017-04-09 04:24:44,670 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a3ecdb7d1ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-09 04:24:45,948 unpacking tar archive at: mozilla-central-2a3ecdb7d1ea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.556978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-09 04:24:46.138279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 04:24:46.138571) ========= script_repo_revision: 2a3ecdb7d1ea814708021fee6735b3aedcf03e48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 04:24:46.138995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 04:24:46.139281) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 04:24:46.159243) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-09 04:24:46.159757) ========= /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.wAIyCm0afI/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.sKFJqTORhf/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:24:46 INFO - MultiFileLogger online at 20170409 04:24:46 in /builds/slave/test 04:24:46 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:24:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:24:46 INFO - {'append_to_log': False, 04:24:46 INFO - 'base_work_dir': '/builds/slave/test', 04:24:46 INFO - 'blob_upload_branch': 'Firefox', 04:24:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:24:46 INFO - 'branch': 'Firefox', 04:24:46 INFO - 'buildbot_json_path': 'buildprops.json', 04:24:46 INFO - 'config_files': ('talos/mac_config.py',), 04:24:46 INFO - 'default_actions': ('clobber', 04:24:46 INFO - 'read-buildbot-config', 04:24:46 INFO - 'download-and-extract', 04:24:46 INFO - 'populate-webroot', 04:24:46 INFO - 'create-virtualenv', 04:24:46 INFO - 'install', 04:24:46 INFO - 'run-tests'), 04:24:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:24:46 INFO - 'download_minidump_stackwalk': True, 04:24:46 INFO - 'download_symbols': 'ondemand', 04:24:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:24:46 INFO - 'tooltool.py': '/tools/tooltool.py', 04:24:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:24:46 INFO - '/tools/misc-python/virtualenv.py')}, 04:24:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:24:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:24:46 INFO - 'gecko_profile': False, 04:24:46 INFO - 'gecko_profile_interval': 0, 04:24:46 INFO - 'installer_path': 'installer.exe', 04:24:46 INFO - 'log_level': 'info', 04:24:46 INFO - 'log_name': 'talos', 04:24:46 INFO - 'log_to_console': True, 04:24:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:24:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:24:46 INFO - 'opt_config_files': (), 04:24:46 INFO - 'pip_index': False, 04:24:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:24:46 INFO - 'cmd': ('bash', 04:24:46 INFO - '-c', 04:24:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:24:46 INFO - 'enabled': True, 04:24:46 INFO - 'halt_on_failure': False, 04:24:46 INFO - 'name': 'check_screen_resolution'},), 04:24:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:24:46 INFO - 'cmd': ('bash', 04:24:46 INFO - '-c', 04:24:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:24:46 INFO - 'enabled': True, 04:24:46 INFO - 'halt_on_failure': False, 04:24:46 INFO - 'name': 'check_screen_resolution'},), 04:24:46 INFO - 'run_cmd_checks_enabled': True, 04:24:46 INFO - 'suite': 'dromaeojs', 04:24:46 INFO - 'system_bits': '32', 04:24:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:24:46 INFO - 'title': 't-yosemite-r7-0240', 04:24:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:24:46 INFO - 'use_talos_json': True, 04:24:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:24:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:24:46 INFO - 'work_dir': 'build'} 04:24:46 INFO - [mozharness: 2017-04-09 11:24:46.378063Z] Running clobber step. 04:24:46 INFO - Running pre-action listener: _resource_record_pre_action 04:24:46 INFO - Running main action method: clobber 04:24:46 INFO - rmtree: /builds/slave/test/build 04:24:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:24:48 INFO - Running post-action listener: _resource_record_post_action 04:24:48 INFO - [mozharness: 2017-04-09 11:24:48.748596Z] Finished clobber step (success) 04:24:48 INFO - [mozharness: 2017-04-09 11:24:48.748727Z] Running read-buildbot-config step. 04:24:48 INFO - Running pre-action listener: _resource_record_pre_action 04:24:48 INFO - Running main action method: read_buildbot_config 04:24:48 INFO - Using buildbot properties: 04:24:48 INFO - { 04:24:48 INFO - "project": "", 04:24:48 INFO - "product": "firefox", 04:24:48 INFO - "script_repo_revision": "production", 04:24:48 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:24:48 INFO - "repository": "", 04:24:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:24:48 INFO - "buildid": "20170409030205", 04:24:48 INFO - "stage_platform": "macosx64", 04:24:48 INFO - "basedir": "/builds/slave/test", 04:24:48 INFO - "nightly_build": "True", 04:24:48 INFO - "buildnumber": 72, 04:24:48 INFO - "slavename": "t-yosemite-r7-0240", 04:24:48 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:24:48 INFO - "platform": "yosemite_r7", 04:24:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:24:48 INFO - "branch": "mozilla-central", 04:24:48 INFO - "repo_path": "mozilla-central", 04:24:48 INFO - "revision": "2a3ecdb7d1ea814708021fee6735b3aedcf03e48", 04:24:48 INFO - "pgo_build": "False", 04:24:48 INFO - "builduid": "a2978479d2784793a733df1f4bc1626b", 04:24:48 INFO - "slavebuilddir": "test" 04:24:48 INFO - } 04:24:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:24:48 INFO - Running post-action listener: _resource_record_post_action 04:24:48 INFO - [mozharness: 2017-04-09 11:24:48.752146Z] Finished read-buildbot-config step (success) 04:24:48 INFO - [mozharness: 2017-04-09 11:24:48.752276Z] Running download-and-extract step. 04:24:48 INFO - Running pre-action listener: _resource_record_pre_action 04:24:48 INFO - Running main action method: download_and_extract 04:24:48 INFO - mkdir: /builds/slave/test/build/tests 04:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:48 INFO - trying https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:24:48 INFO - Downloading https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/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:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/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:24:49 INFO - Downloaded 1325 bytes. 04:24:49 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:24:49 INFO - Using the following test package requirements: 04:24:49 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:24:49 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:24:49 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:24:49 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:24:49 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:24:49 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:24:49 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:24:49 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:24:49 INFO - u'jsshell-mac.zip'], 04:24:49 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:24:49 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:24:49 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:24:49 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:24:49 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:24:49 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:24:49 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:24:49 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:24:49 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:24:49 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:24:49 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:24:49 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:24:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:24:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:24:49 INFO - Fetch https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:24:50 INFO - Expected file size: 52528924 04:24:50 INFO - Obtained file size: 52528924 04:25:07 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:25:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:25:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:25:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:25:09 INFO - Expected file size: 52528924 04:25:09 INFO - Obtained file size: 52528924 04:25:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:25:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:25:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:25:25 INFO - Expected file size: 14404129 04:25:25 INFO - Obtained file size: 14404129 04:25:26 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:25:26 INFO - trying https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:25:26 INFO - Downloading https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/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:25:29 INFO - Downloaded 70989586 bytes. 04:25:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:25:29 INFO - mkdir: /builds/slave/test/properties 04:25:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:25:29 INFO - Writing to file /builds/slave/test/properties/build_url 04:25:29 INFO - Contents: 04:25:29 INFO - build_url:https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:25:30 INFO - Running post-action listener: _resource_record_post_action 04:25:30 INFO - Running post-action listener: set_extra_try_arguments 04:25:30 INFO - [mozharness: 2017-04-09 11:25:30.062884Z] Finished download-and-extract step (success) 04:25:30 INFO - [mozharness: 2017-04-09 11:25:30.062987Z] Running populate-webroot step. 04:25:30 INFO - Running pre-action listener: _resource_record_pre_action 04:25:30 INFO - Running main action method: populate_webroot 04:25:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:25:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:25:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:25:30 INFO - '--tppagecycles', 04:25:30 INFO - '7'], 04:25:30 INFO - 'tests': ['tsvgm']}}, 04:25:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:25:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:25:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:25:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:25:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:25:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:25:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:25:30 INFO - 'talos_options': ['--disable-e10s'], 04:25:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:25:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:25:30 INFO - 'talos_options': ['--disable-e10s'], 04:25:30 INFO - 'tests': ['damp', 'tps']}, 04:25:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:25:30 INFO - 'tests': ['damp', 'tps']}, 04:25:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:25:30 INFO - 'tests': ['dromaeo_dom']}, 04:25:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:25:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:25:30 INFO - 'tests': ['basic_compositor_video']}, 04:25:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:25:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:25:30 INFO - 'tests': ['a11yr', 04:25:30 INFO - 'ts_paint', 04:25:30 INFO - 'tpaint', 04:25:30 INFO - 'sessionrestore', 04:25:30 INFO - 'sessionrestore_no_auto_restore', 04:25:30 INFO - 'tabpaint']}, 04:25:30 INFO - 'other-e10s': {'tests': ['a11yr', 04:25:30 INFO - 'ts_paint', 04:25:30 INFO - 'tpaint', 04:25:30 INFO - 'sessionrestore', 04:25:30 INFO - 'sessionrestore_no_auto_restore', 04:25:30 INFO - 'tabpaint']}, 04:25:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:25:30 INFO - 'ts_paint', 04:25:30 INFO - 'tpaint', 04:25:30 INFO - 'sessionrestore', 04:25:30 INFO - 'sessionrestore_no_auto_restore', 04:25:30 INFO - 'tabpaint']}, 04:25:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:25:30 INFO - 'ts_paint', 04:25:30 INFO - 'tpaint', 04:25:30 INFO - 'sessionrestore', 04:25:30 INFO - 'sessionrestore_no_auto_restore', 04:25:30 INFO - 'tabpaint']}, 04:25:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:25:30 INFO - 'tests': ['a11yr', 04:25:30 INFO - 'ts_paint', 04:25:30 INFO - 'tpaint', 04:25:30 INFO - 'sessionrestore', 04:25:30 INFO - 'sessionrestore_no_auto_restore', 04:25:30 INFO - 'tabpaint']}, 04:25:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:25:30 INFO - 'tests': ['a11yr', 04:25:30 INFO - 'ts_paint', 04:25:30 INFO - 'tpaint', 04:25:30 INFO - 'sessionrestore', 04:25:30 INFO - 'sessionrestore_no_auto_restore', 04:25:30 INFO - 'tabpaint']}, 04:25:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:25:30 INFO - 'tests': ['tsvgx', 04:25:30 INFO - 'tsvgr_opacity', 04:25:30 INFO - 'tart', 04:25:30 INFO - 'tscrollx', 04:25:30 INFO - 'cart', 04:25:30 INFO - 'tsvg_static']}, 04:25:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:25:30 INFO - 'tsvgr_opacity', 04:25:30 INFO - 'tart', 04:25:30 INFO - 'tscrollx', 04:25:30 INFO - 'cart', 04:25:30 INFO - 'tsvg_static']}, 04:25:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:25:30 INFO - 'talos_options': ['--disable-e10s'], 04:25:30 INFO - 'tests': ['tp5o']}, 04:25:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:25:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:25:30 INFO - 'talos_options': ['--disable-e10s', 04:25:30 INFO - '--xperf_path', 04:25:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:30 INFO - 'tests': ['tp5n']}, 04:25:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:25:30 INFO - 'talos_options': ['--xperf_path', 04:25:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:30 INFO - 'tests': ['tp5n']}}, 04:25:30 INFO - 'talos.zip': {'path': '', 04:25:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:25:30 INFO - Running post-action listener: _resource_record_post_action 04:25:30 INFO - [mozharness: 2017-04-09 11:25:30.081633Z] Finished populate-webroot step (success) 04:25:30 INFO - [mozharness: 2017-04-09 11:25:30.081749Z] Running create-virtualenv step. 04:25:30 INFO - Running pre-action listener: _resource_record_pre_action 04:25:30 INFO - Running main action method: create_virtualenv 04:25:30 INFO - Creating virtualenv /builds/slave/test/build/venv 04:25:30 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:25:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:25:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:25:30 INFO - Using real prefix '/tools/python27' 04:25:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:25:30 INFO - Installing distribute.............................................................................................................................................................................................done. 04:25:33 INFO - Installing pip.................done. 04:25:33 INFO - Return code: 0 04:25:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:25:34 INFO - Reading from file tmpfile_stdout 04:25:34 INFO - Output received: 04:25:34 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:25:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:34 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 0x105deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf3dc4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bccd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc1be8>, '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.wAIyCm0afI/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.sKFJqTORhf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:25:34 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:25:34 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:25:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAIyCm0afI/Render', 04:25:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:34 INFO - 'HOME': '/Users/cltbld', 04:25:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:34 INFO - 'LOGNAME': 'cltbld', 04:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:34 INFO - 'MOZ_NO_REMOTE': '1', 04:25:34 INFO - 'NO_EM_RESTART': '1', 04:25:34 INFO - 'PAGER': '/bin/cat', 04:25:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:34 INFO - 'PWD': '/builds/slave/test', 04:25:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:34 INFO - 'SHELL': '/bin/bash', 04:25:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKFJqTORhf/Listeners', 04:25:34 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 04:25:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:34 INFO - 'USER': 'cltbld', 04:25:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:34 INFO - 'XPC_FLAGS': '0x0', 04:25:34 INFO - 'XPC_SERVICE_NAME': '0', 04:25:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:34 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:25:34 INFO - Cleaning up... 04:25:34 INFO - Return code: 0 04:25:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:34 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 0x105deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf3dc4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bccd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc1be8>, '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.wAIyCm0afI/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.sKFJqTORhf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:25:34 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:25:34 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:25:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAIyCm0afI/Render', 04:25:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:34 INFO - 'HOME': '/Users/cltbld', 04:25:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:34 INFO - 'LOGNAME': 'cltbld', 04:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:34 INFO - 'MOZ_NO_REMOTE': '1', 04:25:34 INFO - 'NO_EM_RESTART': '1', 04:25:34 INFO - 'PAGER': '/bin/cat', 04:25:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:34 INFO - 'PWD': '/builds/slave/test', 04:25:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:34 INFO - 'SHELL': '/bin/bash', 04:25:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKFJqTORhf/Listeners', 04:25:34 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 04:25:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:34 INFO - 'USER': 'cltbld', 04:25:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:34 INFO - 'XPC_FLAGS': '0x0', 04:25:34 INFO - 'XPC_SERVICE_NAME': '0', 04:25:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:34 INFO - Downloading/unpacking psutil>=3.1.1 04:25:34 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:25:34 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:25:34 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:25:34 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:25:34 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:25:34 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:25:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:38 INFO - Installing collected packages: psutil 04:25:38 INFO - Running setup.py install for psutil 04:25:38 INFO - building 'psutil._psutil_osx' extension 04:25:38 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:25:39 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:25:39 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:25:39 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:25:39 INFO - building 'psutil._psutil_posix' extension 04:25:39 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:25:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:25:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:25:39 INFO - ^ 04:25:39 INFO - 1 warning generated. 04:25:39 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:25:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:39 INFO - Successfully installed psutil 04:25:39 INFO - Cleaning up... 04:25:39 INFO - Return code: 0 04:25:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf3dc4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bccd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc1be8>, '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.wAIyCm0afI/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.sKFJqTORhf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:25:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAIyCm0afI/Render', 04:25:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:39 INFO - 'HOME': '/Users/cltbld', 04:25:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:39 INFO - 'LOGNAME': 'cltbld', 04:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:39 INFO - 'MOZ_NO_REMOTE': '1', 04:25:39 INFO - 'NO_EM_RESTART': '1', 04:25:39 INFO - 'PAGER': '/bin/cat', 04:25:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:39 INFO - 'PWD': '/builds/slave/test', 04:25:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:39 INFO - 'SHELL': '/bin/bash', 04:25:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKFJqTORhf/Listeners', 04:25:39 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 04:25:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:39 INFO - 'USER': 'cltbld', 04:25:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:39 INFO - 'XPC_FLAGS': '0x0', 04:25:39 INFO - 'XPC_SERVICE_NAME': '0', 04:25:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:25:39 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:25:39 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:25:39 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:25:39 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:25:39 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:25:39 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:25:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:25:42 INFO - Installing collected packages: mozsystemmonitor 04:25:42 INFO - Running setup.py install for mozsystemmonitor 04:25:42 INFO - Successfully installed mozsystemmonitor 04:25:42 INFO - Cleaning up... 04:25:42 INFO - Return code: 0 04:25:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:25:42 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:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 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:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 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 0x105deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf3dc4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bccd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc1be8>, '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.wAIyCm0afI/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.sKFJqTORhf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:25:42 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:25:42 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:25:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAIyCm0afI/Render', 04:25:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:42 INFO - 'HOME': '/Users/cltbld', 04:25:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:42 INFO - 'LOGNAME': 'cltbld', 04:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:42 INFO - 'MOZ_NO_REMOTE': '1', 04:25:42 INFO - 'NO_EM_RESTART': '1', 04:25:42 INFO - 'PAGER': '/bin/cat', 04:25:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:42 INFO - 'PWD': '/builds/slave/test', 04:25:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:42 INFO - 'SHELL': '/bin/bash', 04:25:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKFJqTORhf/Listeners', 04:25:42 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 04:25:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:42 INFO - 'USER': 'cltbld', 04:25:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:42 INFO - 'XPC_FLAGS': '0x0', 04:25:42 INFO - 'XPC_SERVICE_NAME': '0', 04:25:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:43 INFO - Downloading/unpacking jsonschema==2.5.1 04:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:25:45 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:25:45 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:25:45 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:25:45 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:25:45 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:25:45 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:25:46 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:46 INFO - warning: no files found matching '*.txt' 04:25:46 INFO - no previously-included directories found matching 'build' 04:25:46 INFO - no previously-included directories found matching 'dist' 04:25:46 INFO - no previously-included directories found matching '.git*' 04:25:46 INFO - Installing collected packages: jsonschema, functools32 04:25:46 INFO - Running setup.py install for functools32 04:25:46 INFO - warning: no files found matching '*.txt' 04:25:46 INFO - no previously-included directories found matching 'build' 04:25:46 INFO - no previously-included directories found matching 'dist' 04:25:46 INFO - no previously-included directories found matching '.git*' 04:25:46 INFO - Successfully installed jsonschema functools32 04:25:46 INFO - Cleaning up... 04:25:46 INFO - Return code: 0 04:25:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:25:46 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:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:46 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:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:46 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 0x105deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf3dc4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bccd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc1be8>, '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.wAIyCm0afI/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.sKFJqTORhf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:25:46 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:25:46 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:25:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAIyCm0afI/Render', 04:25:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:46 INFO - 'HOME': '/Users/cltbld', 04:25:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:46 INFO - 'LOGNAME': 'cltbld', 04:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:46 INFO - 'MOZ_NO_REMOTE': '1', 04:25:46 INFO - 'NO_EM_RESTART': '1', 04:25:46 INFO - 'PAGER': '/bin/cat', 04:25:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:46 INFO - 'PWD': '/builds/slave/test', 04:25:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:46 INFO - 'SHELL': '/bin/bash', 04:25:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKFJqTORhf/Listeners', 04:25:46 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 04:25:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:46 INFO - 'USER': 'cltbld', 04:25:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:46 INFO - 'XPC_FLAGS': '0x0', 04:25:46 INFO - 'XPC_SERVICE_NAME': '0', 04:25:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:25:46 INFO - Cleaning up... 04:25:46 INFO - Return code: 0 04:25:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25:46 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:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:46 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:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:46 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 0x105deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf3dc4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bccd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc1be8>, '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.wAIyCm0afI/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.sKFJqTORhf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:25:46 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:25:46 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:25:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAIyCm0afI/Render', 04:25:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:46 INFO - 'HOME': '/Users/cltbld', 04:25:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:46 INFO - 'LOGNAME': 'cltbld', 04:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:46 INFO - 'MOZ_NO_REMOTE': '1', 04:25:46 INFO - 'NO_EM_RESTART': '1', 04:25:46 INFO - 'PAGER': '/bin/cat', 04:25:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:46 INFO - 'PWD': '/builds/slave/test', 04:25:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:46 INFO - 'SHELL': '/bin/bash', 04:25:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKFJqTORhf/Listeners', 04:25:46 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 04:25:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:46 INFO - 'USER': 'cltbld', 04:25:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:46 INFO - 'XPC_FLAGS': '0x0', 04:25:46 INFO - 'XPC_SERVICE_NAME': '0', 04:25:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:47 INFO - Downloading/unpacking blobuploader==1.2.4 04:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25:49 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:25:49 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:25:49 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:25:49 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:25:49 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:25:49 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:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25:50 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:25:50 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:25:50 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:25:50 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:25:50 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:25:50 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:25:50 INFO - Downloading docopt-0.6.1.tar.gz 04:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:50 INFO - Running setup.py install for blobuploader 04:25:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:51 INFO - Running setup.py install for requests 04:25:51 INFO - Running setup.py install for docopt 04:25:51 INFO - Successfully installed blobuploader requests docopt 04:25:51 INFO - Cleaning up... 04:25:51 INFO - Return code: 0 04:25:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:51 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:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:51 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:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:51 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 0x105deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf3dc4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bccd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc1be8>, '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.wAIyCm0afI/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.sKFJqTORhf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:25:51 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:25:51 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:25:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAIyCm0afI/Render', 04:25:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:51 INFO - 'HOME': '/Users/cltbld', 04:25:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:51 INFO - 'LOGNAME': 'cltbld', 04:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:51 INFO - 'MOZ_NO_REMOTE': '1', 04:25:51 INFO - 'NO_EM_RESTART': '1', 04:25:51 INFO - 'PAGER': '/bin/cat', 04:25:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:51 INFO - 'PWD': '/builds/slave/test', 04:25:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:51 INFO - 'SHELL': '/bin/bash', 04:25:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKFJqTORhf/Listeners', 04:25:51 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 04:25:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:51 INFO - 'USER': 'cltbld', 04:25:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:51 INFO - 'XPC_FLAGS': '0x0', 04:25:51 INFO - 'XPC_SERVICE_NAME': '0', 04:25:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-PNOWoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-Wm2YW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-tL4dPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-ojymwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-jUHmEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-9pbvgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-1hbpaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-mPNbir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-sum1gY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-veEhGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-AheAPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-v0Jrlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-oTX8qK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-gdS8O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-gMTDSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-uQo7mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-pITIRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:53 INFO - Running setup.py install for manifestparser 04:25:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:54 INFO - Running setup.py install for mozcrash 04:25:54 INFO - Running setup.py install for mozdebug 04:25:54 INFO - Running setup.py install for mozdevice 04:25:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:54 INFO - Running setup.py install for mozfile 04:25:54 INFO - Running setup.py install for mozhttpd 04:25:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:54 INFO - Running setup.py install for mozinfo 04:25:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:54 INFO - Running setup.py install for mozInstall 04:25:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:54 INFO - Running setup.py install for mozleak 04:25:55 INFO - Running setup.py install for mozlog 04:25:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Running setup.py install for moznetwork 04:25:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Running setup.py install for mozprocess 04:25:55 INFO - Running setup.py install for mozprofile 04:25:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Running setup.py install for mozrunner 04:25:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Running setup.py install for mozscreenshot 04:25:56 INFO - Running setup.py install for moztest 04:25:56 INFO - Running setup.py install for mozversion 04:25:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:56 INFO - Cleaning up... 04:25:56 INFO - Return code: 0 04:25:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25: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:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:56 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 0x105deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf3dc4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bccd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc1be8>, '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.wAIyCm0afI/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.sKFJqTORhf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:25:56 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:25:56 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:25:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAIyCm0afI/Render', 04:25:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:56 INFO - 'HOME': '/Users/cltbld', 04:25:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:56 INFO - 'LOGNAME': 'cltbld', 04:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:56 INFO - 'MOZ_NO_REMOTE': '1', 04:25:56 INFO - 'NO_EM_RESTART': '1', 04:25:56 INFO - 'PAGER': '/bin/cat', 04:25:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:56 INFO - 'PWD': '/builds/slave/test', 04:25:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:56 INFO - 'SHELL': '/bin/bash', 04:25:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKFJqTORhf/Listeners', 04:25:56 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 04:25:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:56 INFO - 'USER': 'cltbld', 04:25:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:56 INFO - 'XPC_FLAGS': '0x0', 04:25:56 INFO - 'XPC_SERVICE_NAME': '0', 04:25:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:56 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-RL5bCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:56 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:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:56 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-Vvv3Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:56 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:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:56 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-Hmw_hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:56 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:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:56 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-sWKGc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:57 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:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:57 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-5y1XeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:57 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:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:57 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-64oVt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:57 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:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:57 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-icYK8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:57 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:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:57 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-4k9BdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:57 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:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:57 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-MukCtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:57 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:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:57 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-UZ5QT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:57 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:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:57 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-1PgMZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:57 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:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:57 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-rbkRXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:57 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:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:57 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-mg37T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:58 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:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:58 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-y9916n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:58 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:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:58 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-UeEBGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:58 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:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:58 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-YTuQsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:58 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:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:58 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-qeM6vD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:58 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:25:58 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:25:58 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:25:58 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:25:58 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:25:58 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:25:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:58 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:25:58 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:25:58 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:25:58 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:25:58 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:25:58 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:26:01 INFO - Downloading blessings-1.6.tar.gz 04:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:01 INFO - Installing collected packages: blessings 04:26:01 INFO - Running setup.py install for blessings 04:26:01 INFO - Successfully installed blessings 04:26:01 INFO - Cleaning up... 04:26:01 INFO - Return code: 0 04:26:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:01 INFO - Reading from file tmpfile_stdout 04:26:01 INFO - Current package versions: 04:26:01 INFO - blessings == 1.6 04:26:01 INFO - blobuploader == 1.2.4 04:26:01 INFO - docopt == 0.6.1 04:26:01 INFO - functools32 == 3.2.3-2 04:26:01 INFO - jsonschema == 2.5.1 04:26:01 INFO - manifestparser == 1.1 04:26:01 INFO - mozInstall == 1.12 04:26:01 INFO - mozcrash == 1.0 04:26:01 INFO - mozdebug == 0.1 04:26:01 INFO - mozdevice == 0.50 04:26:01 INFO - mozfile == 1.2 04:26:01 INFO - mozhttpd == 0.7 04:26:01 INFO - mozinfo == 0.9 04:26:01 INFO - mozleak == 0.1 04:26:01 INFO - mozlog == 3.4 04:26:01 INFO - moznetwork == 0.27 04:26:01 INFO - mozprocess == 0.25 04:26:01 INFO - mozprofile == 0.28 04:26:01 INFO - mozrunner == 6.13 04:26:01 INFO - mozscreenshot == 0.1 04:26:01 INFO - mozsystemmonitor == 0.3 04:26:01 INFO - moztest == 0.8 04:26:01 INFO - mozversion == 1.4 04:26:01 INFO - psutil == 3.1.1 04:26:01 INFO - requests == 1.2.3 04:26:01 INFO - wsgiref == 0.1.2 04:26:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26: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:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:01 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 0x105deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf3dc4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bccd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc1be8>, '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.wAIyCm0afI/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.sKFJqTORhf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:26:01 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:26:01 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:26:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAIyCm0afI/Render', 04:26:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:01 INFO - 'HOME': '/Users/cltbld', 04:26:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:01 INFO - 'LOGNAME': 'cltbld', 04:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:01 INFO - 'MOZ_NO_REMOTE': '1', 04:26:01 INFO - 'NO_EM_RESTART': '1', 04:26:01 INFO - 'PAGER': '/bin/cat', 04:26:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:01 INFO - 'PWD': '/builds/slave/test', 04:26:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:01 INFO - 'SHELL': '/bin/bash', 04:26:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKFJqTORhf/Listeners', 04:26:01 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 04:26:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:01 INFO - 'USER': 'cltbld', 04:26:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:01 INFO - 'XPC_FLAGS': '0x0', 04:26:01 INFO - 'XPC_SERVICE_NAME': '0', 04:26:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:01 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:26:01 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:26:01 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:26:01 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:26:01 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:26:01 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:26:01 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:26:01 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:26:01 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:26:01 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:26:01 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:26:01 INFO - Cleaning up... 04:26:01 INFO - Return code: 0 04:26:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26: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:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105deeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcf3dc4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bccd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc1be8>, '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.wAIyCm0afI/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.sKFJqTORhf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:26: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'] in /builds/slave/test/build 04:26: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 04:26:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAIyCm0afI/Render', 04:26:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:01 INFO - 'HOME': '/Users/cltbld', 04:26:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:01 INFO - 'LOGNAME': 'cltbld', 04:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:01 INFO - 'MOZ_NO_REMOTE': '1', 04:26:01 INFO - 'NO_EM_RESTART': '1', 04:26:01 INFO - 'PAGER': '/bin/cat', 04:26:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:01 INFO - 'PWD': '/builds/slave/test', 04:26:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:01 INFO - 'SHELL': '/bin/bash', 04:26:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKFJqTORhf/Listeners', 04:26:01 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 04:26:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:01 INFO - 'USER': 'cltbld', 04:26:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:01 INFO - 'XPC_FLAGS': '0x0', 04:26:01 INFO - 'XPC_SERVICE_NAME': '0', 04:26:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:26:02 INFO - Cleaning up... 04:26:02 INFO - Return code: 0 04:26:02 INFO - Running post-action listener: _resource_record_post_action 04:26:02 INFO - Running post-action listener: _start_resource_monitoring 04:26:02 INFO - Starting resource monitoring. 04:26:02 INFO - [mozharness: 2017-04-09 11:26:02.239904Z] Finished create-virtualenv step (success) 04:26:02 INFO - [mozharness: 2017-04-09 11:26:02.240860Z] Running install step. 04:26:02 INFO - Running pre-action listener: _resource_record_pre_action 04:26:02 INFO - Running main action method: install 04:26:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:02 INFO - Reading from file tmpfile_stdout 04:26:02 INFO - Detecting whether we're running mozinstall >=1.0... 04:26:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:26:02 INFO - Reading from file tmpfile_stdout 04:26:02 INFO - Output received: 04:26:02 INFO - Usage: mozinstall [options] installer 04:26:02 INFO - Options: 04:26:02 INFO - -h, --help show this help message and exit 04:26:02 INFO - -d DEST, --destination=DEST 04:26:02 INFO - Directory to install application into. [default: 04:26:02 INFO - "/builds/slave/test"] 04:26:02 INFO - --app=APP Application being installed. [default: firefox] 04:26:02 INFO - mkdir: /builds/slave/test/build/application 04:26:02 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:26:02 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:26:22 INFO - Reading from file tmpfile_stdout 04:26:22 INFO - Output received: 04:26:22 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:26:22 INFO - Running post-action listener: _resource_record_post_action 04:26:22 INFO - [mozharness: 2017-04-09 11:26:22.446206Z] Finished install step (success) 04:26:22 INFO - [mozharness: 2017-04-09 11:26:22.446344Z] Running run-tests step. 04:26:22 INFO - Running pre-action listener: _resource_record_pre_action 04:26:22 INFO - Running main action method: run_tests 04:26:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:26:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:26:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:26:22 INFO - 2017-04-09 04:26:22.460 screenresolution[1673:16223] starting screenresolution argv=screenresolution get 04:26:22 INFO - 2017-04-09 04:26:22.463 screenresolution[1673:16223] Display 0: 1600x1200x32@60 04:26:22 INFO - 2017-04-09 04:26:22.469 screenresolution[1674:16226] starting screenresolution argv=screenresolution list 04:26:22 INFO - Available Modes on Display 0 04:26:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:26:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:26:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:26:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:26:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:26:22 INFO - Intel Iris: 04:26:22 INFO - Chipset Model: Intel Iris 04:26:22 INFO - Type: GPU 04:26:22 INFO - Bus: Built-In 04:26:22 INFO - VRAM (Dynamic, Max): 1536 MB 04:26:22 INFO - Vendor: Intel (0x8086) 04:26:22 INFO - Device ID: 0x0a2e 04:26:22 INFO - Revision ID: 0x0009 04:26:22 INFO - Displays: 04:26:22 INFO - Display: 04:26:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:26:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:26:22 INFO - Display Serial Number: 1600x1200 60 04:26:22 INFO - Main Display: Yes 04:26:22 INFO - Mirror: Off 04:26:22 INFO - Online: Yes 04:26:22 INFO - Rotation: Supported 04:26:22 INFO - Return code: 0 04:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:26:22 INFO - Python 2.7.3 04:26:22 INFO - Return code: 0 04:26:22 INFO - grabbing minidump binary from tooltool 04:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:22 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 0x105bccd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:26:22 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:26:22 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:26:22 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:26:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:26:22 INFO - Return code: 0 04:26:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:26:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:26:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:26:22 INFO - ENV: RUST_BACKTRACE is now 1 04:26:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:26:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:26:22 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/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0240', '--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:26:22 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/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0240 --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:26:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wAIyCm0afI/Render', 04:26:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:22 INFO - 'HOME': '/Users/cltbld', 04:26:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:22 INFO - 'LOGNAME': 'cltbld', 04:26:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:26:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:22 INFO - 'MOZ_NO_REMOTE': '1', 04:26:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:26:22 INFO - 'NO_EM_RESTART': '1', 04:26:22 INFO - 'PAGER': '/bin/cat', 04:26:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:22 INFO - 'PWD': '/builds/slave/test', 04:26:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:26:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:22 INFO - 'RUST_BACKTRACE': '1', 04:26:22 INFO - 'SHELL': '/bin/bash', 04:26:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKFJqTORhf/Listeners', 04:26:22 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 04:26:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:22 INFO - 'USER': 'cltbld', 04:26:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:22 INFO - 'XPC_FLAGS': '0x0', 04:26:22 INFO - 'XPC_SERVICE_NAME': '0', 04:26:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:22 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/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0240', '--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:26:23 INFO - mozversion application_buildid: 20170409030205 04:26:23 INFO - mozversion application_changeset: 2a3ecdb7d1ea814708021fee6735b3aedcf03e48 04:26:23 INFO - mozversion application_display_name: Nightly 04:26:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:26:23 INFO - mozversion application_name: Firefox 04:26:23 INFO - mozversion application_remotingname: firefox 04:26:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:26:23 INFO - mozversion application_vendor: Mozilla 04:26:23 INFO - mozversion application_version: 55.0a1 04:26:23 INFO - mozversion platform_buildid: 20170409030205 04:26:23 INFO - mozversion platform_changeset: 2a3ecdb7d1ea814708021fee6735b3aedcf03e48 04:26:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:26:23 INFO - mozversion platform_version: 55.0a1 04:26:23 INFO - using testdate: 1491737183 04:26:23 INFO - actual date: 1491737183 04:26:23 INFO - starting webserver on 'localhost:49245' 04:26:23 INFO - SUITE-START | Running 2 tests 04:26:23 INFO - TEST-START | dromaeo_css 04:26:23 INFO - operating with platform_type : mac_ 04:26:23 INFO - Initialising browser for dromaeo_css test... 04:26:23 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmp5bp3pi/profile http://localhost:49245/getInfo.html) 04:26:26 INFO - PID 1684 | __metrics Screen width/height:1600/1200 04:26:26 INFO - PID 1684 | colorDepth:24 04:26:26 INFO - PID 1684 | Browser inner width/height: 1024/689 04:26:26 INFO - PID 1684 | __metrics 04:26:26 INFO - PID 1684 | 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:26:26 INFO - PID 1684 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:27 INFO - TEST-INFO | 1684: exit 0 04:26:27 INFO - Browser initialized. 04:26:27 INFO - Running cycle 1/1 for dromaeo_css test... 04:26:27 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmp5bp3pi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:39 INFO - PID 1688 | RSS: Main: 238456832 04:26:39 INFO - PID 1688 | 04:29:44 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 04:29:46 INFO - PID 1688 | RSS: Main: 384446464 04:29:46 INFO - PID 1688 | 04:31:29 INFO - PID 1688 | ************************* 04:31:29 INFO - PID 1688 | A coding exception was thrown and uncaught in a Task. 04:31:29 INFO - PID 1688 | 04:31:29 ERROR - PID 1688 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:31:29 INFO - PID 1688 | Full stack: 04:31:29 INFO - PID 1688 | ************************* 04:31:29 INFO - PID 1688 | ************************* 04:31:29 INFO - PID 1688 | A coding exception was thrown and uncaught in a Task. 04:31:29 INFO - PID 1688 | 04:31:29 ERROR - PID 1688 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:31:29 INFO - PID 1688 | Full stack: 04:31:29 INFO - PID 1688 | ************************* 04:31:29 INFO - PID 1688 | ************************* 04:31:29 INFO - PID 1688 | A coding exception was thrown and uncaught in a Task. 04:31:29 INFO - PID 1688 | 04:31:29 ERROR - PID 1688 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:31:29 INFO - PID 1688 | Full stack: 04:31:29 INFO - PID 1688 | ************************* 04:31:29 INFO - PID 1688 | ************************* 04:31:29 INFO - PID 1688 | A coding exception was thrown and uncaught in a Task. 04:31:29 INFO - PID 1688 | 04:31:29 ERROR - PID 1688 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:31:29 INFO - PID 1688 | Full stack: 04:31:29 INFO - PID 1688 | ************************* 04:32:49 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 04:32:49 INFO - PID 1688 | RSS: Main: 365518848 04:32:49 INFO - PID 1688 | 04:35:51 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 04:35:52 INFO - PID 1688 | RSS: Main: 334295040 04:35:52 INFO - PID 1688 | 04:38:54 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 04:38:55 INFO - PID 1688 | RSS: Main: 326848512 04:38:55 INFO - PID 1688 | 04:41:59 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 04:41:59 INFO - PID 1688 | RSS: Main: 333414400 04:41:59 INFO - PID 1688 | 04:45:01 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 04:45:02 INFO - PID 1688 | RSS: Main: 377790464 04:45:02 INFO - PID 1688 | 04:45:02 INFO - PID 1688 | __start_tp_report 04:45:02 INFO - PID 1688 | _x_x_mozilla_page_load 04:45:02 INFO - PID 1688 | _x_x_mozilla_page_load_details 04:45:02 INFO - PID 1688 | |i|pagename|runs| 04:45:02 INFO - PID 1688 | |0;dojo.html;3204.5513628092067;3455.412579861423;3463.601685806133;3508.9649103508964;3532.222910959588;6074.088886667002;6117.6941152942345;6137.171481849949;6144.631322120676;6179.443850053494;6048.676790441791;6092.055731361635;6123.755049798003;6138.786925362703;6143.84965262158;4869.70781753096;5203.323567936163;5248.8687782805355;5313.760880760375;5424.105022671254;5361.571074314045;5371.865703357428;5421.566274698014;5424.83725488236;5463.262459567947;5208.817691380784;5250.606204534675;5274.024305503494;5310.256564081032;5332.226827110047;4379.277419225824;5319.787208511693;5346.492083252124;5388.703621300827;5409.486098820606;5303.761330740126;5313.203019547099;5319.122344813101;5345.5990800689715;5361.437049109826;5903.144044113623;5938.8218353449465;5974.253218347707;6092.695365231721;6119.877602447926;6349.174607301067;6379.968100159516;6410.423061924403;6413.6793160341795;6424.743010279583;6451.483881289486;6464.191976003;6560.048792924999;6566.310537393552;6576.177977752781;5711.263881544139;6181.134641150243;6227.564070515065;6234.064890266405;6240;6421.2615549211505;6723.932760672331;6733.696983635748;6736.02327662496;6741.528093033538;6309.022101574264;6321.462675672527;6373;6377;6379.393957574023;6498.155239818888;6521.478281737544;6525.086487891699;6525.738970441129;6544.54188206821;6427.839304017343;6436.710348034349;6440.935590644033;6442.871142577123;6446;6288.402601752826;6363.554551181465;6365.745370185141;6374.84062898422;6438.484921206292;5188.9740551297755;5196.688198708014;5197.038547868657;5202.739863006835;5206.97396513015;3917.8236979335998;4677.883052923704;4680.4149481314835;4681.180793361216;4705.976470117627;6195;6215.316315205324;6246.9062964054665;6247.781327653601;6257.998720204836;6439.066335381343;6488.740450382026;6489.383508566773;6508;6524.608523488606;6032.547558933097;6102.883130681807;6132.78535251264;6169.537284703665;6253.843653908689;5659.207710920475;5711.571632127607;5724.427557244326;5730.7421166047625;5773.826785196451;6688.866222675617;6724.327567243236;6727.461803055744;6734.966325168343;6739.022841688025;6372.776952806629;6375.553711240169;6454.903176452451;6480.773172938924;6502.349765023459;6714.328567143247;6730.865382692221;6731.764388246388;6750.932490675227;6751.45988320943;6391.680415979089;6437.066625339393;6442.645654488861;6446.0975463434215;6448.677566121582;5461.863453413696;6332.588381755171;6465.3857883501;6504.707288171949;6561.96719016421;6316.810495685137;6391.360863913757;6395.16862807832;6395.776147834804;6404.199475065617;6253.499720022296;6373.6175829450385;6375.808725738235;6379.840503987438;6383.96808015957;6087.573869829246;6177.876442471035;6206.06908963659;6248.500119990481;6256.937430625636;5261.947380526299;6344.555881088279;6346.555741098264;6348.841278968062;6350.110984462087;6299.086632438362;6328.367163283635;6328.968355158195;6334.113224148715;6334.746610135543 04:45:02 INFO - PID 1688 | |1;ext.html;759.3697231298023;794.3724457678433;809.6842231529704;1131.4795194210662;1136.295496791989;26660.86669566652;35735.82132089339;36180.733674321404;36212.63787362126;36255.286812714345;38013.61986380135;38254.617453825456;38296.23407531855;38329.23341533168;38383.42424863629;6131.693415329238;6317.1156038154695;8311.418200725951;8519.40364174508;8520.8721869172;6188.040853667666;6272.15325930998;6282.68586570672;6286.151369565096;8372.455790373606;8590.453718330698;8628.266597339234;8628.784280392978;8631.827363452727;8638.956805215965;8514.361422893277;8580.570971451403;8610.999999999969;8632.35257355701;8633.050364459905;8449.450785698971;8526.232639062453;8531.74404767858;8537.573121343908;8547.059823419419;36222.275554489024;36449.81775091134;36537.45193822095;36549.81725091358;36583;3522.137076416269;3551.271989242199;3552.2717842842158;3553.4492153715955;3558.377283975294;24068.759312406826;29686;29781;29802.254943626365;29839.701602984125;3142.6543080261154;3164.27221738999;3190.808551486895;3192.696693814107;3207.983960080208;262928;269297;270186;270593;270747;47242.76378618085;47322.76338618285;47325.76337118361;47367.052658946624;47449;49564.25653615199;49732;49765.50234497681;49836.75081624569;49844.750776245884;14093.365798539091;14211;14220;14222.928885355506;14231.786523201954;11156.665300041012;11637.243579167327;11642.185047046794;11646.301221926711;11666.416679166008;10339.63811266602;10528.894711052792;10540.051395374454;11911.821322680167;12222;5217.373915130209;5329.280547126088;5331.226972089025;5358.196270559447;5362.570994320445;1007.9899201007896;1033.8759348878032;1037.2169012395593;1070.4915165296422;1071.9410432426291;22778.772212277996;23048.66161805517;23904.641430378557;24053.51892962131;24142.275731728078;1021.7088129882948;1094.8248280275118;1137.9601713939971;1179.7640471905654;1181.1908842442954;11034.668959931216;12058.974987126192;12310.79919221009;12380.31908245037;12421.93789031049;329483.35258323554;330440;330702.34648827085;331341;331538;52051.219231711555;52116.73941630268;52143;52271.73864130655;52276.21585676218;1482.9258537073104;1519.4909705248645;1564.2100739126895;1564.608847788053;1574.3781206423398;23344.066237350315;23584.646230306902;23701;23766.881165594063;23882.04471821177;36496.27007459783;36541.81729091337;36567;36585.45121823228;36587.45118823273;207584;208063;208692;209114;209337;33338.166545836546;33347;33364.328993940384;33503.827366042075;34118;37367.43948840715;37713.81143094267;37760.86717398482;44633;44782.10435791201;29163.270918227216;29341.559876602296;30378.54432183563;31165;31379;30195.849020754755;30728.231794205323;30766.384672306875;31171.53242701316;31216.687833121377;35349.82325088461;36289.45565816462;36671.449928250564;36891.07772305714;37001.44497832588;27668.584971225046;29511.11466656004;30452.086437406913;30524.389512210077;31344;21652.860335250985;22952.65571016403;24007.63988540208;24071.277861664177;24428 04:45:02 INFO - PID 1688 | |2;jquery.html;422.92598795210847;434.819549886797;445.4854642887465;445.6390323837692;454.36615920790496;15799.526014219577;20941.267055653054;21504;21642.701437913736;21652.35042948714;20697.275595354167;22430.775692243074;22745.886270568622;22762.65856012161;23058.19296324629;6189.75240990361;6403.839904002414;6406.839829004266;6410.006449000412;6414.102025716404;5669.23465332179;6007.189029481008;6172.105044768506;6193.845153871144;6296.905546416784;6069.544784141185;6235.469985051253;6261.90607140891;6270.184875966118;6274.341194174614;6182.381761823826;6316.589421687599;6322.810315690536;6323.873522529524;6325.746970121189;5413.160960051159;5567;5606.915896261559;5630.4369563043365;5651.886962260773;27124.864375677997;27626.447471050666;27884.024059157833;27978;28321.716782832114;2209.2488553891753;2283.611785996368;2283.8287128465267;2286.554121946221;2291.014863608648;17758.37845675395;17853;17977.280908763634;18366.54083647906;18627.254909803592;2151.064287035145;2154.633712268918;2208.939708939718;2209.7790220977936;2210.723659542557;155372;163790.18104909518;165060;165784;167091.99999999878;12159.574414895436;12177.817332740016;12313.26120432777;12367.381630918419;12555.309457979898;16621.66756664884;16670.58323541897;16707.582310442336;16740.246688899028;16754.497365079067;8672.56637168139;8868.290536757044;9030.381189455116;9031.232345250728;9204.033576474507;8657.047724750273;8660.78348041304;8667.523286219192;8840;8878;6965.373116419547;7040.803063479221;7759;7770.728024519115;7829.177936316719;2025.28102523602;2096.170802054326;2122.7664956854733;2123.575284943018;2273.0453209651987;974.4104816586005;987.9209663226925;991.8561808537721;1014.1582486536157;1034.4724190662816;20701.48074827283;21194.576108477744;21259.89370053171;21285.36143915685;21462.57074858494;870.629982257538;973.756560859785;992.6773798515511;1019.3425240719695;1058.1006144777032;10552.947235263775;10857.131429485622;10894.509747061402;10913.618023369303;10937.45312734376;573609;581661.1833881607;605611;620828;634160;120410.39794801145;157480;158299.20850395673;159615;159619;997.6607953295915;1174.6698110855818;1206.3003457994341;1206.342543313896;1210.0017485574435;17229.82770172282;17874.374396896048;17997.460076197734;18398.356057537923;21506.89246553757;46820.7658961703;59377.70311148417;59400;60295;62367.06449403172;81958;82286.6513676633;83240.58379708305;84070.57964710137;84977;8693.956530217309;8749.693760718344;8839.381243312906;9196.954015229881;9316.301277404085;14166.575002749934;14242.643933901736;14402.85597144015;14540.927295363455;14559.708805823613;11799.17405781587;11914.16600837933;12188.20776649515;12299;12334.568290109803;11138.94430527842;11169.162312826733;11223.71940701489;11300.378479183724;11597.768044638891;10021.699349019542;12154.635360939186;12284.01727861751;12352.444140013542;12370.381480926098;8665.696700615448;8710.259627931697;8802.031776504708;9024.639014439348;9191;11626.360550169822;11806.46870890829;12178.086643501596;12207;12235.449404776984 04:45:02 INFO - PID 1688 | |3;mootools.html;1218.4151607228537;1274.7259339242062;1479.5783201787485;1503.7669161279998;1507.4045751927988;9828.16460600849;10286.177105831533;11426.542938282459;11753.000994915443;11790.351530665832;11558.306501609888;11667.766644667101;11674.533018679263;11690.415479226047;11697.532098716041;2440.3777036855577;2482.366996415911;2487.800975921931;2488.464980029293;2492.2274095030507;1948.9707654385195;2113.2814842953394;2199.3072182262536;2485.2047344849657;2510.3975045989014;2427.6965379327585;2456.9017239310406;2484.1802205272306;2486.7388924162974;2489;2453.717822450414;2479.095130277454;2479.1323036937106;2480.441900572375;2482.950340993188;2284.1662793080404;2406.9157579484636;2439.3657649011384;2449.8040156787415;2465.149523414419;9757.268204884662;11420.257683250562;11526.19316647835;11531.711707207303;11548.884511154865;6298.622082675054;6552.6068435894;6568.80293591193;6579.539432239745;6585.473162147016;3298.719608833252;3917.8354796119434;4110.46563946685;4174.123434078817;4184.8744537663915;1272.9809052864214;1275.8724127587259;1311.5475161069417;1319.1886989501484;1336.0360270402493;15855.207239637972;16204;16204.5138645842;16207.918960405123;16223;5604;5692.174634677948;5730.1404789281105;5871.178035075093;5883.0881213411985;13481.528146514825;13568;13572.321383930765;13576.796348054788;13585.796213056812;6429.678516074177;6535.052417399451;6539.869202615921;6545.312742162099;6564.310747371553;5090.745462726849;5840.094785308284;5947.256592925884;5949.2266005419015;6015.608985416022;4232.915341693149;4345.326474396474;4550.726956382628;4679.742614156254;4704.811807527661;1413.2862904233502;1448.9565313040625;1459.4162335066057;1468.8531146885439;1475.5204558518524;790.6125998260811;794.8410317936435;813.4265342933218;821.4947807098591;848.868425394065;6433.517486188554;6740.292269311652;6838.555493892981;6883.586984780929;6966.268541803139;911.8677791720296;917.775145089444;923.2337160157053;925.0841666749869;961.9374740641836;3736.4768932349493;3746.4380342948775;3748.212875296164;3855.1904100139286;3866.3427217373114;12019.939900300618;14650.780238296435;15073.773893391608;15081.305080255408;15088.849111508964;14887.478938237326;14895.031822931474;14898.702025959421;14901;14976.251187440585;9179.678711245075;10579.471026448648;10639.574417023387;10858.782824343469;10877.347359158633;5147.6139289554185;6436.549441539048;6607.867842643024;6725.630090345078;6733.730650773914;12271.834175753289;13506;13517.121387109806;13563.71144741248;13576.660583485493;13376.458472890119;13796.793048104488;13802.585922422344;13927.860721392657;14008.929955350159;9351.205147562534;9398.154166125081;9478.668246611336;9540.284478663989;9631.518424078908;9515.286353523376;9827.55775990068;9829.4102353859;10268.383896966207;10532.947335263274;9063.41087829289;9122.817543649222;9132.817343653223;9178.082191781035;9228.815423691623;8558.743237702878;8694.782630434289;8950.552472376225;8984.595693193953;9012.053734357798;8116.75649730509;8177.4684645497855;8233.094359620556;8239.258466738022;8247.95876020616;6056.121862329849;6138.109974053827;6162.630242185304;6165.013597824327;6251.374862513712;5289.7355132242465;5538.47384498472;6179.6910154493;6203.906941395792;6288.811335659938 04:45:02 INFO - PID 1688 | |4;prototype.html;375.6562745088244;379.88793305974735;382.7760759955426;383.48038407957233;388.44646378910045;5314.229436731676;5321.388040375353;5792.507636850873;5815.5638327125425;5854.5023672987745;4931.408231012284;5331.306930099082;5572.814176264344;5682.318121825377;5695.316562012554;3794.7343685941855;4202.936955945664;4284.914301713964;4293.892652683677;4316.726565663137;4289.871303860889;4314.460692413449;4317.546657600954;4319.200947824646;4337.07247607865;4039.919201615966;4047.7571345719202;4281.957180428187;4283.6506500452415;4339.717918335314;3478.1826270826336;4240.745555266694;4253.404523366731;4257.254980378452;4288.485381754193;3195.1852277669277;3212.61448626164;3651.835667394974;3698;3703.962960370389;5349.117395629716;5406.189071639246;5620.606557540974;5625.915611265793;5656.490915817555;4815.855524334275;4968.900621987576;5012.8496145115705;5014.724190169539;5018.641238617844;6076.210092687922;6083.239595050619;6083.361247069082;6100.45095941363;6102.908456373158;4153.813078411479;4165.812538435777;4171.687123465722;4191.1827193697245;4191.350340697197;5267.47325267474;6204.906926396107;6283.748650053993;6350.04749287606;6376.968115159394;4086.67306615476;4137.172565486914;4147.087640719037;4221.324588065956;4260.126674031816;3581.9283614328087;3598.766080204831;4299.613034826881;4307.353896915488;4323.481182258086;4863.465018847924;4948.826791062295;4996.800127994912;5035.219540971156;5041.395032596112;5174.534291913746;5259.500347466985;6034.668093254913;6093.634381937098;6171.876562468726;1412.985870141306;1448.9420423183165;1463.7777455824294;1464.3630020940925;1467.2150399536197;810.666453683687;826.6982551368707;869.0353707384797;899.7660608241773;941.6280569175137;5133.409657889316;5300.761465733974;5746.827595172152;5767.8558036049435;5795.623284486495;6267.780627678009;6322.778702745381;6358.950773122383;6379.202599675041;6387.8501869663905;4429.069895322018;4869.4728199184165;5098.362704661918;5796.000379869023;5806.403239109194;3292.5555050067933;3309.5532103166247;3312.90243622214;3315.8176300303717;3320.8671653133606;5484.61607687458;6416.454601358937;6444.967775161094;6489.253735820441;6511.590711436704;5793.971030144822;6354.745810167541;6361.872762544724;6455.419012288917;6465.903011454832;6472.449841763503;6488.513361497812;6489.967550162219;6494.285628580852;6517.9674101630135;5999.690119304012;6190.319064902767;6196.659183744757;6295.559310848196;6312.842178945563;5511.283533140666;6166.167567378347;6249.812505624838;6260.683547087607;6315.778947736807;5330.680159190461;5539.030127609832;6120.540959427972;6349.746010159542;6491.642959637265;4172.185099481614;4173.853915112956;4190.790460477025;4200.7059505834295;4213.283741763847;5503.889922201613;6070.575059745775;6288.591241569284;6312.715927783169;6354.428101470705;5072.82245121419;5380.3274590676165;5488.984537860509;6082.118092876596;6184.81445556634;5088.414832294334;5205.791768329376;5219.895602088013;5433.918491222714;5956.225690660186;4932.580730637936;5738.770449181986;5810.94189058104;5997.580169388276;6027.427394397525;6144.433169541739;6162.630242185483;6165.136880836776;6166.167567378347;6180.721867515883;5463.180522921593;5602.747876345656;5793.797217097382;5976.133460648269;6048.3649216833355 04:45:02 INFO - PID 1688 | |5;yui.html;713.0338391479542;848.9235968762812;870.142909234404;870.30810505648;882.5454890731272;13143.934280328596;13436.731265374687;16942.152892355378;17875.374361897335;17935.910320448413;17147.971121732706;17183.742243866353;17219.569510762238;17231.91384043081;17242.13789310536;975.1223898491361;986.7730422002944;992.3004281981222;995.6863587969766;1000.5947591225565;985.6106837799101;993.4337427666234;1003.2976916158682;1010.5149528226456;1011.5296387179997;1047.8271085270922;1054.2936232724094;1054.6045233037612;1056.5773690523774;1058.2169194795872;1049.6798476464676;1049.8267785815294;1050.6480329089688;1053.6944286157004;1054.3568423261804;773.9342155916697;776.7980325115454;777.5490215674895;778.4122987144669;783.4398405140352;15919.92040039804;15948.840511594968;16453.83546164535;16694;16934.83065169345;16431.014139151688;16552.66894662112;16749.748753768705;16763.66472670552;17117.400890968755;13695.863041369657;13850.307484625728;14078.22569758663;14398.352074156688;14607.415703371853;3616.077900135475;3622.9275414491563;3631.1285291530107;3636.5272514573203;3645.5989841117457;102285.99999999926;107195;109848;110579;110829.89170108276;11267.211295209258;13672.248026358448;13957.860421395859;13960.86039139616;14000.579982600539;17686.380976665754;19180.616387672446;20067.59864802725;25113.24660260195;25131;8900.154485323885;8942.418742781698;9074.500902450296;9121.042290559395;9219.216366608913;4669.673122881433;4766.118268120409;4772.403449568804;4774.809007639656;4781.2350023996;4265.808038638207;4311.310190369526;4380.102079073846;4393.670474714345;4412.426384569985;942.7030485397078;965.8502932045544;972.9221662267001;975.1272611013245;976.7216343342113;540.7728753923361;637.2544123375661;674.6660403100399;683.8700646877078;693.0539813155108;11171.66485005451;11608.30350178992;11811.409429528489;11971.52113915451;12185.817212741817;615.7475435071599;654.3325807676143;657.6941722099247;661.5898143151277;681.2880539835785;5323.547498462596;5368.114261146867;5507.586930980193;5513.2005859150195;5604.579656525777;101721;103250;103809;103864;104611;91345;92102.53948730213;93092.53453732688;93132;94030;75341;79145;79494;81820.59089704632;82335.588322058;10597.89402105969;10754.139668826632;10857.619983300547;10980;11060.677257775957;35131.824340878135;36275.63724362828;39787.2042559153;40140;40461.79769101136;49074.75462622664;49080.509194907594;49611;49966.00067998692;50710.23934640909;11639.41802909868;13636;13699.520516781864;14132;14137.646558836112;14439;14532.910031747873;14673.706525869637;14720.558383248519;14815.25923703789;11420.82868756986;14196.36116374745;14253.857461425669;14394.928025359806;14406;11911.76176476483;13695.452181912611;14144.22206778637;14306.57080287593;14530.491432799801;14014.229217393142;14101.576952691024;14134.010619256553;14187.929060354632;14246.145231286157;10397.896021039995;10423.42671153094;10628.289786104493;10989.285696429706;11027.44862756875;8711.738647840575;10537.52786722814;10773.86874378179;11436.599719009795;11685.474153663276 04:45:02 INFO - PID 1688 | __end_tp_report 04:45:02 INFO - PID 1688 | __start_cc_report 04:45:02 INFO - PID 1688 | _x_x_mozilla_cycle_collect,1603 04:45:02 INFO - PID 1688 | __end_cc_report 04:45:02 INFO - PID 1688 | __startTimestamp1491738302144__endTimestamp 04:45:02 INFO - PID 1688 | 04:45:02 INFO - PID 1688 | ------- Summary: start ------- 04:45:02 INFO - PID 1688 | Number of tests: 6 04:45:02 INFO - PID 1688 | 04:45:02 INFO - PID 1688 | [#0] dojo.html Cycles:165 Average:5992.51 Median:6258.00 stddev:714.80 (11.4%) stddev-sans-first:682.72 04:45:02 INFO - PID 1688 | Values: 3204.6 3455.4 3463.6 3509.0 3532.2 6074.1 6117.7 6137.2 6144.6 6179.4 6048.7 6092.1 6123.8 6138.8 6143.8 4869.7 5203.3 5248.9 5313.8 5424.1 5361.6 5371.9 5421.6 5424.8 5463.3 5208.8 5250.6 5274.0 5310.3 5332.2 4379.3 5319.8 5346.5 5388.7 5409.5 5303.8 5313.2 5319.1 5345.6 5361.4 5903.1 5938.8 5974.3 6092.7 6119.9 6349.2 6380.0 6410.4 6413.7 6424.7 6451.5 6464.2 6560.0 6566.3 6576.2 5711.3 6181.1 6227.6 6234.1 6240.0 6421.3 6723.9 6733.7 6736.0 6741.5 6309.0 6321.5 6373.0 6377.0 6379.4 6498.2 6521.5 6525.1 6525.7 6544.5 6427.8 6436.7 6440.9 6442.9 6446.0 6288.4 6363.6 6365.7 6374.8 6438.5 5189.0 5196.7 5197.0 5202.7 5207.0 3917.8 4677.9 4680.4 4681.2 4706.0 6195.0 6215.3 6246.9 6247.8 6258.0 6439.1 6488.7 6489.4 6508.0 6524.6 6032.5 6102.9 6132.8 6169.5 6253.8 5659.2 5711.6 5724.4 5730.7 5773.8 6688.9 6724.3 6727.5 6735.0 6739.0 6372.8 6375.6 6454.9 6480.8 6502.3 6714.3 6730.9 6731.8 6750.9 6751.5 6391.7 6437.1 6442.6 6446.1 6448.7 5461.9 6332.6 6465.4 6504.7 6562.0 6316.8 6391.4 6395.2 6395.8 6404.2 6253.5 6373.6 6375.8 6379.8 6384.0 6087.6 6177.9 6206.1 6248.5 6256.9 5261.9 6344.6 6346.6 6348.8 6350.1 6299.1 6328.4 6329.0 6334.1 6334.7 04:45:02 INFO - PID 1688 | 04:45:02 INFO - PID 1688 | [#1] ext.html Cycles:180 Average:41917.79 Median:331021.67 stddev:71873.14 (21.7%) stddev-sans-first:72008.33 04:45:02 INFO - PID 1688 | Values: 759.4 794.4 809.7 1131.5 1136.3 26660.9 35735.8 36180.7 36212.6 36255.3 38013.6 38254.6 38296.2 38329.2 38383.4 6131.7 6317.1 8311.4 8519.4 8520.9 6188.0 6272.2 6282.7 6286.2 8372.5 8590.5 8628.3 8628.8 8631.8 8639.0 8514.4 8580.6 8611.0 8632.4 8633.1 8449.5 8526.2 8531.7 8537.6 8547.1 36222.3 36449.8 36537.5 36549.8 36583.0 3522.1 3551.3 3552.3 3553.4 3558.4 24068.8 29686.0 29781.0 29802.3 29839.7 3142.7 3164.3 3190.8 3192.7 3208.0 262928.0 269297.0 270186.0 270593.0 270747.0 47242.8 47322.8 47325.8 47367.1 47449.0 49564.3 49732.0 49765.5 49836.8 49844.8 14093.4 14211.0 14220.0 14222.9 14231.8 11156.7 11637.2 11642.2 11646.3 11666.4 10339.6 10528.9 10540.1 11911.8 12222.0 5217.4 5329.3 5331.2 5358.2 5362.6 1008.0 1033.9 1037.2 1070.5 1071.9 22778.8 23048.7 23904.6 24053.5 24142.3 1021.7 1094.8 1138.0 1179.8 1181.2 11034.7 12059.0 12310.8 12380.3 12421.9 329483.4 330440.0 330702.3 331341.0 331538.0 52051.2 52116.7 52143.0 52271.7 52276.2 1482.9 1519.5 1564.2 1564.6 1574.4 23344.1 23584.6 23701.0 23766.9 23882.0 36496.3 36541.8 36567.0 36585.5 36587.5 207584.0 208063.0 208692.0 209114.0 209337.0 33338.2 33347.0 33364.3 33503.8 34118.0 37367.4 37713.8 37760.9 44633.0 44782.1 29163.3 29341.6 30378.5 31165.0 31379.0 30195.8 30728.2 30766.4 31171.5 31216.7 35349.8 36289.5 36671.4 36891.1 37001.4 27668.6 29511.1 30452.1 30524.4 31344.0 21652.9 22952.7 24007.6 24071.3 24428.0 04:45:02 INFO - PID 1688 | 04:45:02 INFO - PID 1688 | [#2] jquery.html Cycles:180 Average:38115.07 Median:12509.47 stddev:102596.08 (820.1%) stddev-sans-first:102844.86 04:45:02 INFO - PID 1688 | Values: 422.9 434.8 445.5 445.6 454.4 15799.5 20941.3 21504.0 21642.7 21652.4 20697.3 22430.8 22745.9 22762.7 23058.2 6189.8 6403.8 6406.8 6410.0 6414.1 5669.2 6007.2 6172.1 6193.8 6296.9 6069.5 6235.5 6261.9 6270.2 6274.3 6182.4 6316.6 6322.8 6323.9 6325.7 5413.2 5567.0 5606.9 5630.4 5651.9 27124.9 27626.4 27884.0 27978.0 28321.7 2209.2 2283.6 2283.8 2286.6 2291.0 17758.4 17853.0 17977.3 18366.5 18627.3 2151.1 2154.6 2208.9 2209.8 2210.7 155372.0 163790.2 165060.0 165784.0 167092.0 12159.6 12177.8 12313.3 12367.4 12555.3 16621.7 16670.6 16707.6 16740.2 16754.5 8672.6 8868.3 9030.4 9031.2 9204.0 8657.0 8660.8 8667.5 8840.0 8878.0 6965.4 7040.8 7759.0 7770.7 7829.2 2025.3 2096.2 2122.8 2123.6 2273.0 974.4 987.9 991.9 1014.2 1034.5 20701.5 21194.6 21259.9 21285.4 21462.6 870.6 973.8 992.7 1019.3 1058.1 10552.9 10857.1 10894.5 10913.6 10937.5 573609.0 581661.2 605611.0 620828.0 634160.0 120410.4 157480.0 158299.2 159615.0 159619.0 997.7 1174.7 1206.3 1206.3 1210.0 17229.8 17874.4 17997.5 18398.4 21506.9 46820.8 59377.7 59400.0 60295.0 62367.1 81958.0 82286.7 83240.6 84070.6 84977.0 8694.0 8749.7 8839.4 9197.0 9316.3 14166.6 14242.6 14402.9 14540.9 14559.7 11799.2 11914.2 12188.2 12299.0 12334.6 11138.9 11169.2 11223.7 11300.4 11597.8 10021.7 12154.6 12284.0 12352.4 12370.4 8665.7 8710.3 8802.0 9024.6 9191.0 11626.4 11806.5 12178.1 12207.0 12235.4 04:45:02 INFO - PID 1688 | 04:45:02 INFO - PID 1688 | [#3] mootools.html Cycles:180 Average:7108.65 Median:3741.46 stddev:4519.45 (120.8%) stddev-sans-first:4510.46 04:45:02 INFO - PID 1688 | Values: 1218.4 1274.7 1479.6 1503.8 1507.4 9828.2 10286.2 11426.5 11753.0 11790.4 11558.3 11667.8 11674.5 11690.4 11697.5 2440.4 2482.4 2487.8 2488.5 2492.2 1949.0 2113.3 2199.3 2485.2 2510.4 2427.7 2456.9 2484.2 2486.7 2489.0 2453.7 2479.1 2479.1 2480.4 2483.0 2284.2 2406.9 2439.4 2449.8 2465.1 9757.3 11420.3 11526.2 11531.7 11548.9 6298.6 6552.6 6568.8 6579.5 6585.5 3298.7 3917.8 4110.5 4174.1 4184.9 1273.0 1275.9 1311.5 1319.2 1336.0 15855.2 16204.0 16204.5 16207.9 16223.0 5604.0 5692.2 5730.1 5871.2 5883.1 13481.5 13568.0 13572.3 13576.8 13585.8 6429.7 6535.1 6539.9 6545.3 6564.3 5090.7 5840.1 5947.3 5949.2 6015.6 4232.9 4345.3 4550.7 4679.7 4704.8 1413.3 1449.0 1459.4 1468.9 1475.5 790.6 794.8 813.4 821.5 848.9 6433.5 6740.3 6838.6 6883.6 6966.3 911.9 917.8 923.2 925.1 961.9 3736.5 3746.4 3748.2 3855.2 3866.3 12019.9 14650.8 15073.8 15081.3 15088.8 14887.5 14895.0 14898.7 14901.0 14976.3 9179.7 10579.5 10639.6 10858.8 10877.3 5147.6 6436.5 6607.9 6725.6 6733.7 12271.8 13506.0 13517.1 13563.7 13576.7 13376.5 13796.8 13802.6 13927.9 14008.9 9351.2 9398.2 9478.7 9540.3 9631.5 9515.3 9827.6 9829.4 10268.4 10532.9 9063.4 9122.8 9132.8 9178.1 9228.8 8558.7 8694.8 8950.6 8984.6 9012.1 8116.8 8177.5 8233.1 8239.3 8248.0 6056.1 6138.1 6162.6 6165.0 6251.4 5289.7 5538.5 6179.7 6203.9 6288.8 04:45:02 INFO - PID 1688 | 04:45:02 INFO - PID 1688 | [#4] prototype.html Cycles:180 Average:4902.98 Median:5420.05 stddev:1522.22 (28.1%) stddev-sans-first:1488.07 04:45:02 INFO - PID 1688 | Values: 375.7 379.9 382.8 383.5 388.4 5314.2 5321.4 5792.5 5815.6 5854.5 4931.4 5331.3 5572.8 5682.3 5695.3 3794.7 4202.9 4284.9 4293.9 4316.7 4289.9 4314.5 4317.5 4319.2 4337.1 4039.9 4047.8 4282.0 4283.7 4339.7 3478.2 4240.7 4253.4 4257.3 4288.5 3195.2 3212.6 3651.8 3698.0 3704.0 5349.1 5406.2 5620.6 5625.9 5656.5 4815.9 4968.9 5012.8 5014.7 5018.6 6076.2 6083.2 6083.4 6100.5 6102.9 4153.8 4165.8 4171.7 4191.2 4191.4 5267.5 6204.9 6283.7 6350.0 6377.0 4086.7 4137.2 4147.1 4221.3 4260.1 3581.9 3598.8 4299.6 4307.4 4323.5 4863.5 4948.8 4996.8 5035.2 5041.4 5174.5 5259.5 6034.7 6093.6 6171.9 1413.0 1448.9 1463.8 1464.4 1467.2 810.7 826.7 869.0 899.8 941.6 5133.4 5300.8 5746.8 5767.9 5795.6 6267.8 6322.8 6359.0 6379.2 6387.9 4429.1 4869.5 5098.4 5796.0 5806.4 3292.6 3309.6 3312.9 3315.8 3320.9 5484.6 6416.5 6445.0 6489.3 6511.6 5794.0 6354.7 6361.9 6455.4 6465.9 6472.4 6488.5 6490.0 6494.3 6518.0 5999.7 6190.3 6196.7 6295.6 6312.8 5511.3 6166.2 6249.8 6260.7 6315.8 5330.7 5539.0 6120.5 6349.7 6491.6 4172.2 4173.9 4190.8 4200.7 4213.3 5503.9 6070.6 6288.6 6312.7 6354.4 5072.8 5380.3 5489.0 6082.1 6184.8 5088.4 5205.8 5219.9 5433.9 5956.2 4932.6 5738.8 5810.9 5997.6 6027.4 6144.4 6162.6 6165.1 6166.2 6180.7 5463.2 5602.7 5793.8 5976.1 6048.4 04:45:02 INFO - PID 1688 | 04:45:02 INFO - PID 1688 | [#5] yui.html Cycles:180 Average:20443.29 Median:17132.69 stddev:28870.92 (168.5%) stddev-sans-first:28913.90 04:45:02 INFO - PID 1688 | Values: 713.0 848.9 870.1 870.3 882.5 13143.9 13436.7 16942.2 17875.4 17935.9 17148.0 17183.7 17219.6 17231.9 17242.1 975.1 986.8 992.3 995.7 1000.6 985.6 993.4 1003.3 1010.5 1011.5 1047.8 1054.3 1054.6 1056.6 1058.2 1049.7 1049.8 1050.6 1053.7 1054.4 773.9 776.8 777.5 778.4 783.4 15919.9 15948.8 16453.8 16694.0 16934.8 16431.0 16552.7 16749.7 16763.7 17117.4 13695.9 13850.3 14078.2 14398.4 14607.4 3616.1 3622.9 3631.1 3636.5 3645.6 102286.0 107195.0 109848.0 110579.0 110829.9 11267.2 13672.2 13957.9 13960.9 14000.6 17686.4 19180.6 20067.6 25113.2 25131.0 8900.2 8942.4 9074.5 9121.0 9219.2 4669.7 4766.1 4772.4 4774.8 4781.2 4265.8 4311.3 4380.1 4393.7 4412.4 942.7 965.9 972.9 975.1 976.7 540.8 637.3 674.7 683.9 693.1 11171.7 11608.3 11811.4 11971.5 12185.8 615.7 654.3 657.7 661.6 681.3 5323.5 5368.1 5507.6 5513.2 5604.6 101721.0 103250.0 103809.0 103864.0 104611.0 91345.0 92102.5 93092.5 93132.0 94030.0 75341.0 79145.0 79494.0 81820.6 82335.6 10597.9 10754.1 10857.6 10980.0 11060.7 35131.8 36275.6 39787.2 40140.0 40461.8 49074.8 49080.5 49611.0 49966.0 50710.2 11639.4 13636.0 13699.5 14132.0 14137.6 14439.0 14532.9 14673.7 14720.6 14815.3 11420.8 14196.4 14253.9 14394.9 14406.0 11911.8 13695.5 14144.2 14306.6 14530.5 14014.2 14101.6 14134.0 14187.9 14246.1 10397.9 10423.4 10628.3 10989.3 11027.4 8711.7 10537.5 10773.9 11436.6 11685.5 04:45:02 INFO - PID 1688 | -------- Summary: end -------- 04:45:02 INFO - PID 1688 | 04:45:02 INFO - TEST-INFO | 1688: exit 0 04:45:02 INFO - TEST-OK | dromaeo_css | took 1119782ms 04:45:02 INFO - TEST-START | kraken 04:45:02 INFO - operating with platform_type : mac_ 04:45:02 INFO - Initialising browser for kraken test... 04:45:02 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpnKzqub/profile http://localhost:49245/getInfo.html) 04:45:05 INFO - PID 1694 | __metrics Screen width/height:1600/1200 04:45:05 INFO - PID 1694 | colorDepth:24 04:45:05 INFO - PID 1694 | Browser inner width/height: 1024/689 04:45:05 INFO - PID 1694 | __metrics 04:45:05 INFO - PID 1694 | 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:45:05 INFO - PID 1694 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:06 INFO - TEST-INFO | 1694: exit 0 04:45:06 INFO - Browser initialized. 04:45:06 INFO - Running cycle 1/1 for kraken test... 04:45:06 INFO - TEST-INFO | started process 1696 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpnKzqub/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:19 INFO - PID 1696 | RSS: Main: 238321664 04:45:19 INFO - PID 1696 | 04:45:22 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 04:45:23 INFO - PID 1696 | RSS: Main: 291512320 04:45:23 INFO - PID 1696 | 04:45:26 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 04:45:26 INFO - PID 1696 | RSS: Main: 293171200 04:45:26 INFO - PID 1696 | 04:45:30 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 04:45:30 INFO - PID 1696 | RSS: Main: 387231744 04:45:30 INFO - PID 1696 | 04:45:33 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 04:45:33 INFO - PID 1696 | RSS: Main: 290746368 04:45:33 INFO - PID 1696 | 04:45:36 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:45:36 INFO - PID 1696 | RSS: Main: 292466688 04:45:36 INFO - PID 1696 | 04:45:39 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 04:45:40 INFO - PID 1696 | RSS: Main: 334991360 04:45:40 INFO - PID 1696 | 04:45:43 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 04:45:44 INFO - PID 1696 | RSS: Main: 345427968 04:45:44 INFO - PID 1696 | 04:45:47 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 04:45:47 INFO - PID 1696 | RSS: Main: 349999104 04:45:47 INFO - PID 1696 | 04:45:49 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:45:50 INFO - PID 1696 | RSS: Main: 310378496 04:45:50 INFO - PID 1696 | 04:45:52 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:45:52 INFO - PID 1696 | RSS: Main: 312700928 04:45:52 INFO - PID 1696 | 04:45:55 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:45:55 INFO - PID 1696 | RSS: Main: 314617856 04:45:55 INFO - PID 1696 | 04:45:59 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:45:59 INFO - PID 1696 | RSS: Main: 333320192 04:45:59 INFO - PID 1696 | 04:46:03 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:46:04 INFO - PID 1696 | RSS: Main: 314077184 04:46:04 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 04:46:06 INFO - PID 1696 | RSS: Main: 380780544 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | __start_tp_report 04:46:06 INFO - PID 1696 | _x_x_mozilla_page_load 04:46:06 INFO - PID 1696 | _x_x_mozilla_page_load_details 04:46:06 INFO - PID 1696 | |i|pagename|runs| 04:46:06 INFO - PID 1696 | |0;ai-astar;110;122;122;121;120;121;122;121;124;129 04:46:06 INFO - PID 1696 | |1;audio-beat-detection;156;122;118;164;118;118;123;159;151;119 04:46:06 INFO - PID 1696 | |2;audio-dft;214;207;215;213;210;212;209;213;212;215 04:46:06 INFO - PID 1696 | |3;audio-fft;85;65;88;129;99;66;62;66;84;64 04:46:06 INFO - PID 1696 | |4;audio-oscillator;95;76;110;60;95;111;133;111;97;91 04:46:06 INFO - PID 1696 | |5;imaging-gaussian-blur;95;93;95;96;94;93;95;99;94;94 04:46:06 INFO - PID 1696 | |6;imaging-darkroom;102;101;103;101;101;102;103;100;102;100 04:46:06 INFO - PID 1696 | |7;imaging-desaturate;101;100;103;100;100;99;134;153;101;100 04:46:06 INFO - PID 1696 | |8;json-parse-financial;53;51;52;50;53;52;52;53;53;52 04:46:06 INFO - PID 1696 | |9;json-stringify-tinderbox;57;62;78;97;97;92;84;64;64;64 04:46:06 INFO - PID 1696 | |10;stanford-crypto-aes;116;117;91;115;115;117;95;87;90;88 04:46:06 INFO - PID 1696 | |11;stanford-crypto-ccm;171;166;173;157;160;169;161;153;203;172 04:46:06 INFO - PID 1696 | |12;stanford-crypto-pbkdf2;278;266;209;200;249;257;192;183;252;213 04:46:06 INFO - PID 1696 | |13;stanford-crypto-sha256-iterative;74;72;72;72;72;73;71;72;74;73 04:46:06 INFO - PID 1696 | __end_tp_report 04:46:06 INFO - PID 1696 | __start_cc_report 04:46:06 INFO - PID 1696 | _x_x_mozilla_cycle_collect,2185 04:46:06 INFO - PID 1696 | __end_cc_report 04:46:06 INFO - PID 1696 | __startTimestamp1491738366369__endTimestamp 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | ------- Summary: start ------- 04:46:06 INFO - PID 1696 | Number of tests: 14 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#0] ai-astar Cycles:10 Average:121.20 Median:122.00 stddev:4.69 (3.8%) stddev-sans-first:2.70 04:46:06 INFO - PID 1696 | Values: 110.0 122.0 122.0 121.0 120.0 121.0 122.0 121.0 124.0 129.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:137.00 stddev:19.86 (14.5%) stddev-sans-first:19.53 04:46:06 INFO - PID 1696 | Values: 156.0 122.0 118.0 164.0 118.0 118.0 123.0 159.0 151.0 119.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#2] audio-dft Cycles:10 Average:212.00 Median:213.00 stddev:2.62 (1.2%) stddev-sans-first:2.68 04:46:06 INFO - PID 1696 | Values: 214.0 207.0 215.0 213.0 210.0 212.0 209.0 213.0 212.0 215.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:21.23 (28.3%) stddev-sans-first:22.47 04:46:06 INFO - PID 1696 | Values: 85.0 65.0 88.0 129.0 99.0 66.0 62.0 66.0 84.0 64.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:83.50 stddev:20.28 (24.3%) stddev-sans-first:21.49 04:46:06 INFO - PID 1696 | Values: 95.0 76.0 110.0 60.0 95.0 111.0 133.0 111.0 97.0 91.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:95.00 stddev:1.75 (1.8%) stddev-sans-first:1.86 04:46:06 INFO - PID 1696 | Values: 95.0 93.0 95.0 96.0 94.0 93.0 95.0 99.0 94.0 94.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#6] imaging-darkroom Cycles:10 Average:101.50 Median:102.00 stddev:1.08 (1.1%) stddev-sans-first:1.13 04:46:06 INFO - PID 1696 | Values: 102.0 101.0 103.0 101.0 101.0 102.0 103.0 100.0 102.0 100.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#7] imaging-desaturate Cycles:10 Average:109.10 Median:102.00 stddev:18.71 (18.3%) stddev-sans-first:19.61 04:46:06 INFO - PID 1696 | Values: 101.0 100.0 103.0 100.0 100.0 99.0 134.0 153.0 101.0 100.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.50 stddev:0.99 (1.9%) stddev-sans-first:1.00 04:46:06 INFO - PID 1696 | Values: 53.0 51.0 52.0 50.0 53.0 52.0 52.0 53.0 53.0 52.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#9] json-stringify-tinderbox Cycles:10 Average:75.90 Median:81.00 stddev:15.62 (19.3%) stddev-sans-first:14.99 04:46:06 INFO - PID 1696 | Values: 57.0 62.0 78.0 97.0 97.0 92.0 84.0 64.0 64.0 64.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#10] stanford-crypto-aes Cycles:10 Average:103.10 Median:87.50 stddev:13.77 (15.7%) stddev-sans-first:13.79 04:46:06 INFO - PID 1696 | Values: 116.0 117.0 91.0 115.0 115.0 117.0 95.0 87.0 90.0 88.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#11] stanford-crypto-ccm Cycles:10 Average:168.50 Median:170.00 stddev:13.89 (8.2%) stddev-sans-first:14.70 04:46:06 INFO - PID 1696 | Values: 171.0 166.0 173.0 157.0 160.0 169.0 161.0 153.0 203.0 172.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:229.90 Median:250.50 stddev:34.09 (13.6%) stddev-sans-first:31.40 04:46:06 INFO - PID 1696 | Values: 278.0 266.0 209.0 200.0 249.0 257.0 192.0 183.0 252.0 213.0 04:46:06 INFO - PID 1696 | 04:46:06 INFO - PID 1696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.50 stddev:0.97 (1.3%) stddev-sans-first:0.87 04:46:06 INFO - PID 1696 | Values: 74.0 72.0 72.0 72.0 72.0 73.0 71.0 72.0 74.0 73.0 04:46:06 INFO - PID 1696 | -------- Summary: end -------- 04:46:06 INFO - PID 1696 | 04:46:07 INFO - TEST-INFO | 1696: exit 0 04:46:07 INFO - TEST-OK | kraken | took 64614ms 04:46:07 INFO - SUITE-END | took 1184s 04:46:07 INFO - Completed test suite (00:19:44) 04:46:07 INFO - javascript benchmark 04:46:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7668.721053908368, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3204.5513628092067, 3455.412579861423, 3463.601685806133, 3508.9649103508964, 3532.222910959588, 6074.088886667002, 6117.6941152942345, 6137.171481849949, 6144.631322120676, 6179.443850053494, 6048.676790441791, 6092.055731361635, 6123.755049798003, 6138.786925362703, 6143.84965262158, 4869.70781753096, 5203.323567936163, 5248.8687782805355, 5313.760880760375, 5424.105022671254, 5361.571074314045, 5371.865703357428, 5421.566274698014, 5424.83725488236, 5463.262459567947, 5208.817691380784, 5250.606204534675, 5274.024305503494, 5310.256564081032, 5332.226827110047, 4379.277419225824, 5319.787208511693, 5346.492083252124, 5388.703621300827, 5409.486098820606, 5303.761330740126, 5313.203019547099, 5319.122344813101, 5345.5990800689715, 5361.437049109826, 5903.144044113623, 5938.8218353449465, 5974.253218347707, 6092.695365231721, 6119.877602447926, 6349.174607301067, 6379.968100159516, 6410.423061924403, 6413.6793160341795, 6424.743010279583, 6451.483881289486, 6464.191976003, 6560.048792924999, 6566.310537393552, 6576.177977752781, 5711.263881544139, 6181.134641150243, 6227.564070515065, 6234.064890266405, 6240.0, 6421.2615549211505, 6723.932760672331, 6733.696983635748, 6736.02327662496, 6741.528093033538, 6309.022101574264, 6321.462675672527, 6373.0, 6377.0, 6379.393957574023, 6498.155239818888, 6521.478281737544, 6525.086487891699, 6525.738970441129, 6544.54188206821, 6427.839304017343, 6436.710348034349, 6440.935590644033, 6442.871142577123, 6446.0, 6288.402601752826, 6363.554551181465, 6365.745370185141, 6374.84062898422, 6438.484921206292, 5188.9740551297755, 5196.688198708014, 5197.038547868657, 5202.739863006835, 5206.97396513015, 3917.8236979335998, 4677.883052923704, 4680.4149481314835, 4681.180793361216, 4705.976470117627, 6195.0, 6215.316315205324, 6246.9062964054665, 6247.781327653601, 6257.998720204836, 6439.066335381343, 6488.740450382026, 6489.383508566773, 6508.0, 6524.608523488606, 6032.547558933097, 6102.883130681807, 6132.78535251264, 6169.537284703665, 6253.843653908689, 5659.207710920475, 5711.571632127607, 5724.427557244326, 5730.7421166047625, 5773.826785196451, 6688.866222675617, 6724.327567243236, 6727.461803055744, 6734.966325168343, 6739.022841688025, 6372.776952806629, 6375.553711240169, 6454.903176452451, 6480.773172938924, 6502.349765023459, 6714.328567143247, 6730.865382692221, 6731.764388246388, 6750.932490675227, 6751.45988320943, 6391.680415979089, 6437.066625339393, 6442.645654488861, 6446.0975463434215, 6448.677566121582, 5461.863453413696, 6332.588381755171, 6465.3857883501, 6504.707288171949, 6561.96719016421, 6316.810495685137, 6391.360863913757, 6395.16862807832, 6395.776147834804, 6404.199475065617, 6253.499720022296, 6373.6175829450385, 6375.808725738235, 6379.840503987438, 6383.96808015957, 6087.573869829246, 6177.876442471035, 6206.06908963659, 6248.500119990481, 6256.937430625636, 5261.947380526299, 6344.555881088279, 6346.555741098264, 6348.841278968062, 6350.110984462087, 6299.086632438362, 6328.367163283635, 6328.968355158195, 6334.113224148715, 6334.746610135543], "value": 5943.950801865962, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.3697231298023, 794.3724457678433, 809.6842231529704, 1131.4795194210662, 1136.295496791989, 26660.86669566652, 35735.82132089339, 36180.733674321404, 36212.63787362126, 36255.286812714345, 38013.61986380135, 38254.617453825456, 38296.23407531855, 38329.23341533168, 38383.42424863629, 6131.693415329238, 6317.1156038154695, 8311.418200725951, 8519.40364174508, 8520.8721869172, 6188.040853667666, 6272.15325930998, 6282.68586570672, 6286.151369565096, 8372.455790373606, 8590.453718330698, 8628.266597339234, 8628.784280392978, 8631.827363452727, 8638.956805215965, 8514.361422893277, 8580.570971451403, 8610.999999999969, 8632.35257355701, 8633.050364459905, 8449.450785698971, 8526.232639062453, 8531.74404767858, 8537.573121343908, 8547.059823419419, 36222.275554489024, 36449.81775091134, 36537.45193822095, 36549.81725091358, 36583.0, 3522.137076416269, 3551.271989242199, 3552.2717842842158, 3553.4492153715955, 3558.377283975294, 24068.759312406826, 29686.0, 29781.0, 29802.254943626365, 29839.701602984125, 3142.6543080261154, 3164.27221738999, 3190.808551486895, 3192.696693814107, 3207.983960080208, 262928.0, 269297.0, 270186.0, 270593.0, 270747.0, 47242.76378618085, 47322.76338618285, 47325.76337118361, 47367.052658946624, 47449.0, 49564.25653615199, 49732.0, 49765.50234497681, 49836.75081624569, 49844.750776245884, 14093.365798539091, 14211.0, 14220.0, 14222.928885355506, 14231.786523201954, 11156.665300041012, 11637.243579167327, 11642.185047046794, 11646.301221926711, 11666.416679166008, 10339.63811266602, 10528.894711052792, 10540.051395374454, 11911.821322680167, 12222.0, 5217.373915130209, 5329.280547126088, 5331.226972089025, 5358.196270559447, 5362.570994320445, 1007.9899201007896, 1033.8759348878032, 1037.2169012395593, 1070.4915165296422, 1071.9410432426291, 22778.772212277996, 23048.66161805517, 23904.641430378557, 24053.51892962131, 24142.275731728078, 1021.7088129882948, 1094.8248280275118, 1137.9601713939971, 1179.7640471905654, 1181.1908842442954, 11034.668959931216, 12058.974987126192, 12310.79919221009, 12380.31908245037, 12421.93789031049, 329483.35258323554, 330440.0, 330702.34648827085, 331341.0, 331538.0, 52051.219231711555, 52116.73941630268, 52143.0, 52271.73864130655, 52276.21585676218, 1482.9258537073104, 1519.4909705248645, 1564.2100739126895, 1564.608847788053, 1574.3781206423398, 23344.066237350315, 23584.646230306902, 23701.0, 23766.881165594063, 23882.04471821177, 36496.27007459783, 36541.81729091337, 36567.0, 36585.45121823228, 36587.45118823273, 207584.0, 208063.0, 208692.0, 209114.0, 209337.0, 33338.166545836546, 33347.0, 33364.328993940384, 33503.827366042075, 34118.0, 37367.43948840715, 37713.81143094267, 37760.86717398482, 44633.0, 44782.10435791201, 29163.270918227216, 29341.559876602296, 30378.54432183563, 31165.0, 31379.0, 30195.849020754755, 30728.231794205323, 30766.384672306875, 31171.53242701316, 31216.687833121377, 35349.82325088461, 36289.45565816462, 36671.449928250564, 36891.07772305714, 37001.44497832588, 27668.584971225046, 29511.11466656004, 30452.086437406913, 30524.389512210077, 31344.0, 21652.860335250985, 22952.65571016403, 24007.63988540208, 24071.277861664177, 24428.0], "value": 16852.847837332713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.92598795210847, 434.819549886797, 445.4854642887465, 445.6390323837692, 454.36615920790496, 15799.526014219577, 20941.267055653054, 21504.0, 21642.701437913736, 21652.35042948714, 20697.275595354167, 22430.775692243074, 22745.886270568622, 22762.65856012161, 23058.19296324629, 6189.75240990361, 6403.839904002414, 6406.839829004266, 6410.006449000412, 6414.102025716404, 5669.23465332179, 6007.189029481008, 6172.105044768506, 6193.845153871144, 6296.905546416784, 6069.544784141185, 6235.469985051253, 6261.90607140891, 6270.184875966118, 6274.341194174614, 6182.381761823826, 6316.589421687599, 6322.810315690536, 6323.873522529524, 6325.746970121189, 5413.160960051159, 5567.0, 5606.915896261559, 5630.4369563043365, 5651.886962260773, 27124.864375677997, 27626.447471050666, 27884.024059157833, 27978.0, 28321.716782832114, 2209.2488553891753, 2283.611785996368, 2283.8287128465267, 2286.554121946221, 2291.014863608648, 17758.37845675395, 17853.0, 17977.280908763634, 18366.54083647906, 18627.254909803592, 2151.064287035145, 2154.633712268918, 2208.939708939718, 2209.7790220977936, 2210.723659542557, 155372.0, 163790.18104909518, 165060.0, 165784.0, 167091.99999999878, 12159.574414895436, 12177.817332740016, 12313.26120432777, 12367.381630918419, 12555.309457979898, 16621.66756664884, 16670.58323541897, 16707.582310442336, 16740.246688899028, 16754.497365079067, 8672.56637168139, 8868.290536757044, 9030.381189455116, 9031.232345250728, 9204.033576474507, 8657.047724750273, 8660.78348041304, 8667.523286219192, 8840.0, 8878.0, 6965.373116419547, 7040.803063479221, 7759.0, 7770.728024519115, 7829.177936316719, 2025.28102523602, 2096.170802054326, 2122.7664956854733, 2123.575284943018, 2273.0453209651987, 974.4104816586005, 987.9209663226925, 991.8561808537721, 1014.1582486536157, 1034.4724190662816, 20701.48074827283, 21194.576108477744, 21259.89370053171, 21285.36143915685, 21462.57074858494, 870.629982257538, 973.756560859785, 992.6773798515511, 1019.3425240719695, 1058.1006144777032, 10552.947235263775, 10857.131429485622, 10894.509747061402, 10913.618023369303, 10937.45312734376, 573609.0, 581661.1833881607, 605611.0, 620828.0, 634160.0, 120410.39794801145, 157480.0, 158299.20850395673, 159615.0, 159619.0, 997.6607953295915, 1174.6698110855818, 1206.3003457994341, 1206.342543313896, 1210.0017485574435, 17229.82770172282, 17874.374396896048, 17997.460076197734, 18398.356057537923, 21506.89246553757, 46820.7658961703, 59377.70311148417, 59400.0, 60295.0, 62367.06449403172, 81958.0, 82286.6513676633, 83240.58379708305, 84070.57964710137, 84977.0, 8693.956530217309, 8749.693760718344, 8839.381243312906, 9196.954015229881, 9316.301277404085, 14166.575002749934, 14242.643933901736, 14402.85597144015, 14540.927295363455, 14559.708805823613, 11799.17405781587, 11914.16600837933, 12188.20776649515, 12299.0, 12334.568290109803, 11138.94430527842, 11169.162312826733, 11223.71940701489, 11300.378479183724, 11597.768044638891, 10021.699349019542, 12154.635360939186, 12284.01727861751, 12352.444140013542, 12370.381480926098, 8665.696700615448, 8710.259627931697, 8802.031776504708, 9024.639014439348, 9191.0, 11626.360550169822, 11806.46870890829, 12178.086643501596, 12207.0, 12235.449404776984], "value": 10608.719063963736, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1218.4151607228537, 1274.7259339242062, 1479.5783201787485, 1503.7669161279998, 1507.4045751927988, 9828.16460600849, 10286.177105831533, 11426.542938282459, 11753.000994915443, 11790.351530665832, 11558.306501609888, 11667.766644667101, 11674.533018679263, 11690.415479226047, 11697.532098716041, 2440.3777036855577, 2482.366996415911, 2487.800975921931, 2488.464980029293, 2492.2274095030507, 1948.9707654385195, 2113.2814842953394, 2199.3072182262536, 2485.2047344849657, 2510.3975045989014, 2427.6965379327585, 2456.9017239310406, 2484.1802205272306, 2486.7388924162974, 2489.0, 2453.717822450414, 2479.095130277454, 2479.1323036937106, 2480.441900572375, 2482.950340993188, 2284.1662793080404, 2406.9157579484636, 2439.3657649011384, 2449.8040156787415, 2465.149523414419, 9757.268204884662, 11420.257683250562, 11526.19316647835, 11531.711707207303, 11548.884511154865, 6298.622082675054, 6552.6068435894, 6568.80293591193, 6579.539432239745, 6585.473162147016, 3298.719608833252, 3917.8354796119434, 4110.46563946685, 4174.123434078817, 4184.8744537663915, 1272.9809052864214, 1275.8724127587259, 1311.5475161069417, 1319.1886989501484, 1336.0360270402493, 15855.207239637972, 16204.0, 16204.5138645842, 16207.918960405123, 16223.0, 5604.0, 5692.174634677948, 5730.1404789281105, 5871.178035075093, 5883.0881213411985, 13481.528146514825, 13568.0, 13572.321383930765, 13576.796348054788, 13585.796213056812, 6429.678516074177, 6535.052417399451, 6539.869202615921, 6545.312742162099, 6564.310747371553, 5090.745462726849, 5840.094785308284, 5947.256592925884, 5949.2266005419015, 6015.608985416022, 4232.915341693149, 4345.326474396474, 4550.726956382628, 4679.742614156254, 4704.811807527661, 1413.2862904233502, 1448.9565313040625, 1459.4162335066057, 1468.8531146885439, 1475.5204558518524, 790.6125998260811, 794.8410317936435, 813.4265342933218, 821.4947807098591, 848.868425394065, 6433.517486188554, 6740.292269311652, 6838.555493892981, 6883.586984780929, 6966.268541803139, 911.8677791720296, 917.775145089444, 923.2337160157053, 925.0841666749869, 961.9374740641836, 3736.4768932349493, 3746.4380342948775, 3748.212875296164, 3855.1904100139286, 3866.3427217373114, 12019.939900300618, 14650.780238296435, 15073.773893391608, 15081.305080255408, 15088.849111508964, 14887.478938237326, 14895.031822931474, 14898.702025959421, 14901.0, 14976.251187440585, 9179.678711245075, 10579.471026448648, 10639.574417023387, 10858.782824343469, 10877.347359158633, 5147.6139289554185, 6436.549441539048, 6607.867842643024, 6725.630090345078, 6733.730650773914, 12271.834175753289, 13506.0, 13517.121387109806, 13563.71144741248, 13576.660583485493, 13376.458472890119, 13796.793048104488, 13802.585922422344, 13927.860721392657, 14008.929955350159, 9351.205147562534, 9398.154166125081, 9478.668246611336, 9540.284478663989, 9631.518424078908, 9515.286353523376, 9827.55775990068, 9829.4102353859, 10268.383896966207, 10532.947335263274, 9063.41087829289, 9122.817543649222, 9132.817343653223, 9178.082191781035, 9228.815423691623, 8558.743237702878, 8694.782630434289, 8950.552472376225, 8984.595693193953, 9012.053734357798, 8116.75649730509, 8177.4684645497855, 8233.094359620556, 8239.258466738022, 8247.95876020616, 6056.121862329849, 6138.109974053827, 6162.630242185304, 6165.013597824327, 6251.374862513712, 5289.7355132242465, 5538.47384498472, 6179.6910154493, 6203.906941395792, 6288.811335659938], "value": 5374.605678538461, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.6562745088244, 379.88793305974735, 382.7760759955426, 383.48038407957233, 388.44646378910045, 5314.229436731676, 5321.388040375353, 5792.507636850873, 5815.5638327125425, 5854.5023672987745, 4931.408231012284, 5331.306930099082, 5572.814176264344, 5682.318121825377, 5695.316562012554, 3794.7343685941855, 4202.936955945664, 4284.914301713964, 4293.892652683677, 4316.726565663137, 4289.871303860889, 4314.460692413449, 4317.546657600954, 4319.200947824646, 4337.07247607865, 4039.919201615966, 4047.7571345719202, 4281.957180428187, 4283.6506500452415, 4339.717918335314, 3478.1826270826336, 4240.745555266694, 4253.404523366731, 4257.254980378452, 4288.485381754193, 3195.1852277669277, 3212.61448626164, 3651.835667394974, 3698.0, 3703.962960370389, 5349.117395629716, 5406.189071639246, 5620.606557540974, 5625.915611265793, 5656.490915817555, 4815.855524334275, 4968.900621987576, 5012.8496145115705, 5014.724190169539, 5018.641238617844, 6076.210092687922, 6083.239595050619, 6083.361247069082, 6100.45095941363, 6102.908456373158, 4153.813078411479, 4165.812538435777, 4171.687123465722, 4191.1827193697245, 4191.350340697197, 5267.47325267474, 6204.906926396107, 6283.748650053993, 6350.04749287606, 6376.968115159394, 4086.67306615476, 4137.172565486914, 4147.087640719037, 4221.324588065956, 4260.126674031816, 3581.9283614328087, 3598.766080204831, 4299.613034826881, 4307.353896915488, 4323.481182258086, 4863.465018847924, 4948.826791062295, 4996.800127994912, 5035.219540971156, 5041.395032596112, 5174.534291913746, 5259.500347466985, 6034.668093254913, 6093.634381937098, 6171.876562468726, 1412.985870141306, 1448.9420423183165, 1463.7777455824294, 1464.3630020940925, 1467.2150399536197, 810.666453683687, 826.6982551368707, 869.0353707384797, 899.7660608241773, 941.6280569175137, 5133.409657889316, 5300.761465733974, 5746.827595172152, 5767.8558036049435, 5795.623284486495, 6267.780627678009, 6322.778702745381, 6358.950773122383, 6379.202599675041, 6387.8501869663905, 4429.069895322018, 4869.4728199184165, 5098.362704661918, 5796.000379869023, 5806.403239109194, 3292.5555050067933, 3309.5532103166247, 3312.90243622214, 3315.8176300303717, 3320.8671653133606, 5484.61607687458, 6416.454601358937, 6444.967775161094, 6489.253735820441, 6511.590711436704, 5793.971030144822, 6354.745810167541, 6361.872762544724, 6455.419012288917, 6465.903011454832, 6472.449841763503, 6488.513361497812, 6489.967550162219, 6494.285628580852, 6517.9674101630135, 5999.690119304012, 6190.319064902767, 6196.659183744757, 6295.559310848196, 6312.842178945563, 5511.283533140666, 6166.167567378347, 6249.812505624838, 6260.683547087607, 6315.778947736807, 5330.680159190461, 5539.030127609832, 6120.540959427972, 6349.746010159542, 6491.642959637265, 4172.185099481614, 4173.853915112956, 4190.790460477025, 4200.7059505834295, 4213.283741763847, 5503.889922201613, 6070.575059745775, 6288.591241569284, 6312.715927783169, 6354.428101470705, 5072.82245121419, 5380.3274590676165, 5488.984537860509, 6082.118092876596, 6184.81445556634, 5088.414832294334, 5205.791768329376, 5219.895602088013, 5433.918491222714, 5956.225690660186, 4932.580730637936, 5738.770449181986, 5810.94189058104, 5997.580169388276, 6027.427394397525, 6144.433169541739, 6162.630242185483, 6165.136880836776, 6166.167567378347, 6180.721867515883, 5463.180522921593, 5602.747876345656, 5793.797217097382, 5976.133460648269, 6048.3649216833355], "value": 4426.246744718739, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.0338391479542, 848.9235968762812, 870.142909234404, 870.30810505648, 882.5454890731272, 13143.934280328596, 13436.731265374687, 16942.152892355378, 17875.374361897335, 17935.910320448413, 17147.971121732706, 17183.742243866353, 17219.569510762238, 17231.91384043081, 17242.13789310536, 975.1223898491361, 986.7730422002944, 992.3004281981222, 995.6863587969766, 1000.5947591225565, 985.6106837799101, 993.4337427666234, 1003.2976916158682, 1010.5149528226456, 1011.5296387179997, 1047.8271085270922, 1054.2936232724094, 1054.6045233037612, 1056.5773690523774, 1058.2169194795872, 1049.6798476464676, 1049.8267785815294, 1050.6480329089688, 1053.6944286157004, 1054.3568423261804, 773.9342155916697, 776.7980325115454, 777.5490215674895, 778.4122987144669, 783.4398405140352, 15919.92040039804, 15948.840511594968, 16453.83546164535, 16694.0, 16934.83065169345, 16431.014139151688, 16552.66894662112, 16749.748753768705, 16763.66472670552, 17117.400890968755, 13695.863041369657, 13850.307484625728, 14078.22569758663, 14398.352074156688, 14607.415703371853, 3616.077900135475, 3622.9275414491563, 3631.1285291530107, 3636.5272514573203, 3645.5989841117457, 102285.99999999926, 107195.0, 109848.0, 110579.0, 110829.89170108276, 11267.211295209258, 13672.248026358448, 13957.860421395859, 13960.86039139616, 14000.579982600539, 17686.380976665754, 19180.616387672446, 20067.59864802725, 25113.24660260195, 25131.0, 8900.154485323885, 8942.418742781698, 9074.500902450296, 9121.042290559395, 9219.216366608913, 4669.673122881433, 4766.118268120409, 4772.403449568804, 4774.809007639656, 4781.2350023996, 4265.808038638207, 4311.310190369526, 4380.102079073846, 4393.670474714345, 4412.426384569985, 942.7030485397078, 965.8502932045544, 972.9221662267001, 975.1272611013245, 976.7216343342113, 540.7728753923361, 637.2544123375661, 674.6660403100399, 683.8700646877078, 693.0539813155108, 11171.66485005451, 11608.30350178992, 11811.409429528489, 11971.52113915451, 12185.817212741817, 615.7475435071599, 654.3325807676143, 657.6941722099247, 661.5898143151277, 681.2880539835785, 5323.547498462596, 5368.114261146867, 5507.586930980193, 5513.2005859150195, 5604.579656525777, 101721.0, 103250.0, 103809.0, 103864.0, 104611.0, 91345.0, 92102.53948730213, 93092.53453732688, 93132.0, 94030.0, 75341.0, 79145.0, 79494.0, 81820.59089704632, 82335.588322058, 10597.89402105969, 10754.139668826632, 10857.619983300547, 10980.0, 11060.677257775957, 35131.824340878135, 36275.63724362828, 39787.2042559153, 40140.0, 40461.79769101136, 49074.75462622664, 49080.509194907594, 49611.0, 49966.00067998692, 50710.23934640909, 11639.41802909868, 13636.0, 13699.520516781864, 14132.0, 14137.646558836112, 14439.0, 14532.910031747873, 14673.706525869637, 14720.558383248519, 14815.25923703789, 11420.82868756986, 14196.36116374745, 14253.857461425669, 14394.928025359806, 14406.0, 11911.76176476483, 13695.452181912611, 14144.22206778637, 14306.57080287593, 14530.491432799801, 14014.229217393142, 14101.576952691024, 14134.010619256553, 14187.929060354632, 14246.145231286157, 10397.896021039995, 10423.42671153094, 10628.289786104493, 10989.285696429706, 11027.44862756875, 8711.738647840575, 10537.52786722814, 10773.86874378179, 11436.599719009795, 11685.474153663276], "value": 8044.722787936363, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1654.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 122.0, 122.0, 121.0, 120.0, 121.0, 122.0, 121.0, 124.0, 129.0], "value": 121.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 118.0, 164.0, 118.0, 118.0, 123.0, 159.0, 151.0, 119.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 207.0, 215.0, 213.0, 210.0, 212.0, 209.0, 213.0, 212.0, 215.0], "value": 212.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 65.0, 88.0, 129.0, 99.0, 66.0, 62.0, 66.0, 84.0, 64.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 76.0, 110.0, 60.0, 95.0, 111.0, 133.0, 111.0, 97.0, 91.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 95.0, 96.0, 94.0, 93.0, 95.0, 99.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 103.0, 101.0, 101.0, 102.0, 103.0, 100.0, 102.0, 100.0], "value": 101.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 100.0, 103.0, 100.0, 100.0, 99.0, 134.0, 153.0, 101.0, 100.0], "value": 109.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 50.0, 53.0, 52.0, 52.0, 53.0, 53.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 62.0, 78.0, 97.0, 97.0, 92.0, 84.0, 64.0, 64.0, 64.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 91.0, 115.0, 115.0, 117.0, 95.0, 87.0, 90.0, 88.0], "value": 103.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 166.0, 173.0, 157.0, 160.0, 169.0, 161.0, 153.0, 203.0, 172.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [278.0, 266.0, 209.0, 200.0, 249.0, 257.0, 192.0, 183.0, 252.0, 213.0], "value": 229.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 72.0, 72.0, 72.0, 73.0, 71.0, 72.0, 74.0, 73.0], "value": 72.5, "unit": "score"}]}]} 04:46:07 INFO - Return code: 0 04:46:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:46:07 ERROR - # TBPL SUCCESS # 04:46:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:46:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:46:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:46:07 INFO - 2017-04-09 04:46:07.684 screenresolution[1700:18564] starting screenresolution argv=screenresolution get 04:46:07 INFO - 2017-04-09 04:46:07.687 screenresolution[1700:18564] Display 0: 1600x1200x32@60 04:46:07 INFO - 2017-04-09 04:46:07.693 screenresolution[1701:18567] starting screenresolution argv=screenresolution list 04:46:07 INFO - Available Modes on Display 0 04:46:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:46:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:46:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:46:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:46:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:46:07 INFO - Intel Iris: 04:46:07 INFO - Chipset Model: Intel Iris 04:46:07 INFO - Type: GPU 04:46:07 INFO - Bus: Built-In 04:46:07 INFO - VRAM (Dynamic, Max): 1536 MB 04:46:07 INFO - Vendor: Intel (0x8086) 04:46:07 INFO - Device ID: 0x0a2e 04:46:07 INFO - Revision ID: 0x0009 04:46:07 INFO - Displays: 04:46:07 INFO - Display: 04:46:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:46:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:46:07 INFO - Display Serial Number: 1600x1200 60 04:46:07 INFO - Main Display: Yes 04:46:07 INFO - Mirror: Off 04:46:07 INFO - Online: Yes 04:46:07 INFO - Rotation: Supported 04:46:07 INFO - Return code: 0 04:46:07 INFO - Running post-action listener: _resource_record_post_action 04:46:07 INFO - [mozharness: 2017-04-09 11:46:07.941322Z] Finished run-tests step (success) 04:46:07 INFO - Running post-run listener: _resource_record_post_run 04:46:08 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 32377856; Write bytes: 522133504; Read time: 190; Write time: 1621 04:46:08 INFO - TinderboxPrint: CPU usage
53.5% 04:46:08 INFO - TinderboxPrint: I/O read bytes / time
32,377,856 / 190 04:46:08 INFO - TinderboxPrint: I/O write bytes / time
522,133,504 / 1,621 04:46:08 INFO - TinderboxPrint: CPU idle
2,242.6 (46.5%) 04:46:08 INFO - TinderboxPrint: CPU system
963.7 (20.0%) 04:46:08 INFO - TinderboxPrint: CPU user
1,615.5 (33.5%) 04:46:08 INFO - TinderboxPrint: Swap in / out
236,015,616 / 0 04:46:08 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207145472; Write bytes: 202608640; Read time: 16046; Write time: 452 04:46:08 INFO - run-tests - Wall time: 1185s; CPU: 53.0%; Read bytes: 30276608; Write bytes: 312320000; Read time: 171; Write time: 1140 04:46:08 INFO - Running post-run listener: _upload_blobber_files 04:46:08 INFO - Blob upload gear active. 04:46:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:46:08 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 04:46:08 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'] 04:46:08 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 04:46:08 INFO - (blobuploader) - INFO - Open directory for files ... 04:46:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:46:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:46:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:09 INFO - (blobuploader) - INFO - Done attempting. 04:46:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:46:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:46:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:10 INFO - (blobuploader) - INFO - Done attempting. 04:46:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:46:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:46:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:11 INFO - (blobuploader) - INFO - Done attempting. 04:46:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:46:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:13 INFO - (blobuploader) - INFO - Done attempting. 04:46:13 INFO - (blobuploader) - INFO - Iteration through files over. 04:46:13 INFO - Return code: 0 04:46:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:46:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:46:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd85966b201b6cd37bf092adefd9bf9069d39f0e10fbc8036b8e98f6473d2b317710c9fa7a85c6501a148484bf60ba484851a39dbcceb82857b5ac42e7a4a400", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8185a184c6c1107737a33e89aeaadd67ef4a426ed3ca7f458b9aec5d3f716b14f127b31792ab821526302f7f77eaf0d7e0b4779590a7fefb35cf8f00ca3cb3e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e83640c343e4d16c2cc3aed6ec6ce920df9161357bf5ccb7fd5791d2e88fbb761a0a2a197baf8f9fa396751d7e40380394b1b4a4161f2c16e3b27babf6bac9b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96552347c2dddbc09914aee710e80b5b172efb601aed45ea9246733f201f0ca3ffcf94f736803edb11a8dd7b00eb474e045de96e5ffb69ea6b409db99fe5e7cd"} 04:46:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:46:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:46:13 INFO - Contents: 04:46:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd85966b201b6cd37bf092adefd9bf9069d39f0e10fbc8036b8e98f6473d2b317710c9fa7a85c6501a148484bf60ba484851a39dbcceb82857b5ac42e7a4a400", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8185a184c6c1107737a33e89aeaadd67ef4a426ed3ca7f458b9aec5d3f716b14f127b31792ab821526302f7f77eaf0d7e0b4779590a7fefb35cf8f00ca3cb3e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e83640c343e4d16c2cc3aed6ec6ce920df9161357bf5ccb7fd5791d2e88fbb761a0a2a197baf8f9fa396751d7e40380394b1b4a4161f2c16e3b27babf6bac9b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96552347c2dddbc09914aee710e80b5b172efb601aed45ea9246733f201f0ca3ffcf94f736803edb11a8dd7b00eb474e045de96e5ffb69ea6b409db99fe5e7cd"} 04:46:13 INFO - Running post-run listener: copy_logs_to_upload_dir 04:46:13 INFO - Copying logs to upload dir... 04:46:13 INFO - mkdir: /builds/slave/test/build/upload/logs 04:46:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.841749 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-09 04:46:14.046314) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 04:46:14.051772) ========= 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.wAIyCm0afI/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.sKFJqTORhf/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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/dd85966b201b6cd37bf092adefd9bf9069d39f0e10fbc8036b8e98f6473d2b317710c9fa7a85c6501a148484bf60ba484851a39dbcceb82857b5ac42e7a4a400", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8185a184c6c1107737a33e89aeaadd67ef4a426ed3ca7f458b9aec5d3f716b14f127b31792ab821526302f7f77eaf0d7e0b4779590a7fefb35cf8f00ca3cb3e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e83640c343e4d16c2cc3aed6ec6ce920df9161357bf5ccb7fd5791d2e88fbb761a0a2a197baf8f9fa396751d7e40380394b1b4a4161f2c16e3b27babf6bac9b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96552347c2dddbc09914aee710e80b5b172efb601aed45ea9246733f201f0ca3ffcf94f736803edb11a8dd7b00eb474e045de96e5ffb69ea6b409db99fe5e7cd"} build_url:https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/ExWQhDo4TimieFlUxCbFfg/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/dd85966b201b6cd37bf092adefd9bf9069d39f0e10fbc8036b8e98f6473d2b317710c9fa7a85c6501a148484bf60ba484851a39dbcceb82857b5ac42e7a4a400", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8185a184c6c1107737a33e89aeaadd67ef4a426ed3ca7f458b9aec5d3f716b14f127b31792ab821526302f7f77eaf0d7e0b4779590a7fefb35cf8f00ca3cb3e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e83640c343e4d16c2cc3aed6ec6ce920df9161357bf5ccb7fd5791d2e88fbb761a0a2a197baf8f9fa396751d7e40380394b1b4a4161f2c16e3b27babf6bac9b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96552347c2dddbc09914aee710e80b5b172efb601aed45ea9246733f201f0ca3ffcf94f736803edb11a8dd7b00eb474e045de96e5ffb69ea6b409db99fe5e7cd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 04:46:14.087436) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:46:14.087851) ========= 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.wAIyCm0afI/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.sKFJqTORhf/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.005019 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:46:14.137283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 04:46:14.137607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 04:46:14.137973) ========= ========= Total master_lag: 0.19 =========