builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0079 starttime: 1493220362.28 results: success (0) buildid: 20170426073340 builduid: ccfbd12626bf4de9a2d084878da27bd6 revision: c19247505a48b4353ba4f4115daa88181d66108e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 08:26:02.275998) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 08:26:02.276395) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 08:26:02.276670) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 08:26:02.334784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-26 08:26:02.335140) ========= 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.2ZgPZIDCJE/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.pFoO11jCby/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-26 08:26:02-- 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% 47.2M=0s 2017-04-26 08:26:02 (47.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.181873 ========= master_lag: 3.47 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-26 08:26:05.987409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 08:26:05.987754) ========= 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.2ZgPZIDCJE/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.pFoO11jCby/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.022364 ========= master_lag: 0.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 08:26:06.224285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-26 08:26:06.224656) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c19247505a48b4353ba4f4115daa88181d66108e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c19247505a48b4353ba4f4115daa88181d66108e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2ZgPZIDCJE/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.pFoO11jCby/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-26 08:26:06,310 truncating revision to first 12 chars 2017-04-26 08:26:06,310 Setting DEBUG logging. 2017-04-26 08:26:06,310 attempt 1/10 2017-04-26 08:26:06,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c19247505a48?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-26 08:26:07,471 unpacking tar archive at: mozilla-beta-c19247505a48/testing/mozharness/ program finished with exit code 0 elapsedTime=1.407600 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-26 08:26:07.659549) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 08:26:07.659897) ========= script_repo_revision: c19247505a48b4353ba4f4115daa88181d66108e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 08:26:07.660346) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 08:26:07.660648) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 08:26:07.681169) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-26 08:26:07.681573) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2ZgPZIDCJE/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.pFoO11jCby/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 08:26:07 INFO - MultiFileLogger online at 20170426 08:26:07 in /builds/slave/test 08:26:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:26:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:26:07 INFO - {'append_to_log': False, 08:26:07 INFO - 'base_work_dir': '/builds/slave/test', 08:26:07 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:26:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:26:07 INFO - 'branch': 'Mozilla-Beta', 08:26:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:26:07 INFO - 'config_files': ('talos/mac_config.py',), 08:26:07 INFO - 'default_actions': ('clobber', 08:26:07 INFO - 'read-buildbot-config', 08:26:07 INFO - 'download-and-extract', 08:26:07 INFO - 'populate-webroot', 08:26:07 INFO - 'create-virtualenv', 08:26:07 INFO - 'install', 08:26:07 INFO - 'run-tests'), 08:26:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:26:07 INFO - 'download_minidump_stackwalk': True, 08:26:07 INFO - 'download_symbols': 'ondemand', 08:26:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:26:07 INFO - 'tooltool.py': '/tools/tooltool.py', 08:26:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:26:07 INFO - '/tools/misc-python/virtualenv.py')}, 08:26:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:26:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:26:07 INFO - 'gecko_profile': False, 08:26:07 INFO - 'gecko_profile_interval': 0, 08:26:07 INFO - 'installer_path': 'installer.exe', 08:26:07 INFO - 'log_level': 'info', 08:26:07 INFO - 'log_name': 'talos', 08:26:07 INFO - 'log_to_console': True, 08:26:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:26:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:26:07 INFO - 'opt_config_files': (), 08:26:07 INFO - 'pip_index': False, 08:26:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:26:07 INFO - 'cmd': ('bash', 08:26:07 INFO - '-c', 08:26:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:26:07 INFO - 'enabled': True, 08:26:07 INFO - 'halt_on_failure': False, 08:26:07 INFO - 'name': 'check_screen_resolution'},), 08:26:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:26:07 INFO - 'cmd': ('bash', 08:26:07 INFO - '-c', 08:26:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:26:07 INFO - 'enabled': True, 08:26:07 INFO - 'halt_on_failure': False, 08:26:07 INFO - 'name': 'check_screen_resolution'},), 08:26:07 INFO - 'run_cmd_checks_enabled': True, 08:26:07 INFO - 'suite': 'dromaeojs', 08:26:07 INFO - 'system_bits': '32', 08:26:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:26:07 INFO - 'title': 't-yosemite-r7-0079', 08:26:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:26:07 INFO - 'use_talos_json': True, 08:26:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:26:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:26:07 INFO - 'work_dir': 'build'} 08:26:07 INFO - [mozharness: 2017-04-26 15:26:07.891611Z] Running clobber step. 08:26:07 INFO - Running pre-action listener: _resource_record_pre_action 08:26:07 INFO - Running main action method: clobber 08:26:07 INFO - rmtree: /builds/slave/test/build 08:26:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:26:09 INFO - Running post-action listener: _resource_record_post_action 08:26:09 INFO - [mozharness: 2017-04-26 15:26:09.729967Z] Finished clobber step (success) 08:26:09 INFO - [mozharness: 2017-04-26 15:26:09.730121Z] Running read-buildbot-config step. 08:26:09 INFO - Running pre-action listener: _resource_record_pre_action 08:26:09 INFO - Running main action method: read_buildbot_config 08:26:09 INFO - Using buildbot properties: 08:26:09 INFO - { 08:26:09 INFO - "project": "", 08:26:09 INFO - "product": "firefox", 08:26:09 INFO - "script_repo_revision": "production", 08:26:09 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:26:09 INFO - "repository": "", 08:26:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:26:09 INFO - "buildid": "20170426073340", 08:26:09 INFO - "pgo_build": "False", 08:26:09 INFO - "basedir": "/builds/slave/test", 08:26:09 INFO - "buildnumber": 14, 08:26:09 INFO - "slavename": "t-yosemite-r7-0079", 08:26:09 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:26:09 INFO - "platform": "yosemite_r7", 08:26:09 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:26:09 INFO - "branch": "mozilla-beta", 08:26:09 INFO - "repo_path": "releases/mozilla-beta", 08:26:09 INFO - "revision": "c19247505a48b4353ba4f4115daa88181d66108e", 08:26:09 INFO - "stage_platform": "macosx64", 08:26:09 INFO - "builduid": "ccfbd12626bf4de9a2d084878da27bd6", 08:26:09 INFO - "slavebuilddir": "test" 08:26:09 INFO - } 08:26:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 08:26:09 INFO - Running post-action listener: _resource_record_post_action 08:26:09 INFO - [mozharness: 2017-04-26 15:26:09.735768Z] Finished read-buildbot-config step (success) 08:26:09 INFO - [mozharness: 2017-04-26 15:26:09.735975Z] Running download-and-extract step. 08:26:09 INFO - Running pre-action listener: _resource_record_pre_action 08:26:09 INFO - Running main action method: download_and_extract 08:26:09 INFO - mkdir: /builds/slave/test/build/tests 08:26:09 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')]} 08:26:09 INFO - trying https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 08:26:09 INFO - Downloading https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 08:26:10 INFO - Downloaded 1165 bytes. 08:26:10 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:26:10 INFO - Using the following test package requirements: 08:26:10 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:26:10 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:26:10 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 08:26:10 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:26:10 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 08:26:10 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:26:10 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:26:10 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 08:26:10 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:26:10 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:26:10 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 08:26:10 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:26:10 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 08:26:10 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:26:10 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 08:26:10 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:26:10 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 08:26:10 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 08:26:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:26:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:26:10 INFO - Fetch https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:26:12 INFO - Expected file size: 51222042 08:26:12 INFO - Obtained file size: 51222042 08:26:28 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:26:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:26:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:26:28 INFO - Fetch https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:26:31 INFO - Expected file size: 51222042 08:26:31 INFO - Obtained file size: 51222042 08:26:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 08:26:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 08:26:46 INFO - Fetch https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 08:26:47 INFO - Expected file size: 14404449 08:26:47 INFO - Obtained file size: 14404449 08:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:47 INFO - trying https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:26:47 INFO - Downloading https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 08:26:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 08:26:49 INFO - Downloaded 59540859 bytes. 08:26:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:26:49 INFO - mkdir: /builds/slave/test/properties 08:26:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:26:49 INFO - Writing to file /builds/slave/test/properties/build_url 08:26:49 INFO - Contents: 08:26:49 INFO - build_url:https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:26:50 INFO - Running post-action listener: _resource_record_post_action 08:26:50 INFO - Running post-action listener: set_extra_try_arguments 08:26:50 INFO - [mozharness: 2017-04-26 15:26:50.335127Z] Finished download-and-extract step (success) 08:26:50 INFO - [mozharness: 2017-04-26 15:26:50.335271Z] Running populate-webroot step. 08:26:50 INFO - Running pre-action listener: _resource_record_pre_action 08:26:50 INFO - Running main action method: populate_webroot 08:26:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:26:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:26:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:26:50 INFO - '--tppagecycles', 08:26:50 INFO - '7'], 08:26:50 INFO - 'tests': ['tsvgm']}}, 08:26:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:26:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:26:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:26:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:26:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:26:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:26:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:26:50 INFO - 'talos_options': ['--disable-e10s'], 08:26:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:26:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:26:50 INFO - 'talos_options': ['--disable-e10s'], 08:26:50 INFO - 'tests': ['damp', 'tps']}, 08:26:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:26:50 INFO - 'tests': ['damp', 'tps']}, 08:26:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:26:50 INFO - 'tests': ['dromaeo_dom']}, 08:26:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:26:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:26:50 INFO - 'tests': ['basic_compositor_video']}, 08:26:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:26:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:26:50 INFO - 'tests': ['a11yr', 08:26:50 INFO - 'ts_paint', 08:26:50 INFO - 'tpaint', 08:26:50 INFO - 'sessionrestore', 08:26:50 INFO - 'sessionrestore_no_auto_restore', 08:26:50 INFO - 'tabpaint']}, 08:26:50 INFO - 'other-e10s': {'tests': ['a11yr', 08:26:50 INFO - 'ts_paint', 08:26:50 INFO - 'tpaint', 08:26:50 INFO - 'sessionrestore', 08:26:50 INFO - 'sessionrestore_no_auto_restore', 08:26:50 INFO - 'tabpaint']}, 08:26:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:26:50 INFO - 'ts_paint', 08:26:50 INFO - 'tpaint', 08:26:50 INFO - 'sessionrestore', 08:26:50 INFO - 'sessionrestore_no_auto_restore', 08:26:50 INFO - 'tabpaint']}, 08:26:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:26:50 INFO - 'ts_paint', 08:26:50 INFO - 'tpaint', 08:26:50 INFO - 'sessionrestore', 08:26:50 INFO - 'sessionrestore_no_auto_restore', 08:26:50 INFO - 'tabpaint']}, 08:26:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:26:50 INFO - 'tests': ['a11yr', 08:26:50 INFO - 'ts_paint', 08:26:50 INFO - 'tpaint', 08:26:50 INFO - 'sessionrestore', 08:26:50 INFO - 'sessionrestore_no_auto_restore', 08:26:50 INFO - 'tabpaint']}, 08:26:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:26:50 INFO - 'tests': ['a11yr', 08:26:50 INFO - 'ts_paint', 08:26:50 INFO - 'tpaint', 08:26:50 INFO - 'sessionrestore', 08:26:50 INFO - 'sessionrestore_no_auto_restore', 08:26:50 INFO - 'tabpaint']}, 08:26:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:26:50 INFO - 'tests': ['tsvgx', 08:26:50 INFO - 'tsvgr_opacity', 08:26:50 INFO - 'tart', 08:26:50 INFO - 'tscrollx', 08:26:50 INFO - 'cart', 08:26:50 INFO - 'tsvg_static']}, 08:26:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:26:50 INFO - 'tsvgr_opacity', 08:26:50 INFO - 'tart', 08:26:50 INFO - 'tscrollx', 08:26:50 INFO - 'cart', 08:26:50 INFO - 'tsvg_static']}, 08:26:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:26:50 INFO - 'talos_options': ['--disable-e10s'], 08:26:50 INFO - 'tests': ['tp5o']}, 08:26:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:26:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:26:50 INFO - 'talos_options': ['--disable-e10s', 08:26:50 INFO - '--xperf_path', 08:26:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:50 INFO - 'tests': ['tp5n']}, 08:26:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:26:50 INFO - 'talos_options': ['--xperf_path', 08:26:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:50 INFO - 'tests': ['tp5n']}}, 08:26:50 INFO - 'talos.zip': {'path': '', 08:26:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:26:50 INFO - Running post-action listener: _resource_record_post_action 08:26:50 INFO - [mozharness: 2017-04-26 15:26:50.354280Z] Finished populate-webroot step (success) 08:26:50 INFO - [mozharness: 2017-04-26 15:26:50.354391Z] Running create-virtualenv step. 08:26:50 INFO - Running pre-action listener: _resource_record_pre_action 08:26:50 INFO - Running main action method: create_virtualenv 08:26:50 INFO - Creating virtualenv /builds/slave/test/build/venv 08:26:50 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 08:26:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:26:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:26:50 INFO - Using real prefix '/tools/python27' 08:26:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:26:51 INFO - Installing distribute.............................................................................................................................................................................................done. 08:26:54 INFO - Installing pip.................done. 08:26:54 INFO - Return code: 0 08:26:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:26:54 INFO - Reading from file tmpfile_stdout 08:26:54 INFO - Output received: 08:26:54 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) 08:26:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:26:54 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')]} 08:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:54 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')]} 08:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:54 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 0x1033e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff319dae750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bed30>, '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 0x1030e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031b3be8>, '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.2ZgPZIDCJE/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.pFoO11jCby/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 08:26:54 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 08:26:54 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 08:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ZgPZIDCJE/Render', 08:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:54 INFO - 'HOME': '/Users/cltbld', 08:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:54 INFO - 'LOGNAME': 'cltbld', 08:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:54 INFO - 'MOZ_NO_REMOTE': '1', 08:26:54 INFO - 'NO_EM_RESTART': '1', 08:26:54 INFO - 'PAGER': '/bin/cat', 08:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:54 INFO - 'PWD': '/builds/slave/test', 08:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:54 INFO - 'SHELL': '/bin/bash', 08:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFoO11jCby/Listeners', 08:26:54 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:54 INFO - 'USER': 'cltbld', 08:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:54 INFO - 'XPC_FLAGS': '0x0', 08:26:54 INFO - 'XPC_SERVICE_NAME': '0', 08:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:54 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 08:26:54 INFO - Cleaning up... 08:26:54 INFO - Return code: 0 08:26:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:26:54 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')]} 08:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:54 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')]} 08:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:54 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 0x1033e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff319dae750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bed30>, '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 0x1030e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031b3be8>, '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.2ZgPZIDCJE/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.pFoO11jCby/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 08:26:54 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 08:26:54 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 08:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ZgPZIDCJE/Render', 08:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:54 INFO - 'HOME': '/Users/cltbld', 08:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:54 INFO - 'LOGNAME': 'cltbld', 08:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:54 INFO - 'MOZ_NO_REMOTE': '1', 08:26:54 INFO - 'NO_EM_RESTART': '1', 08:26:54 INFO - 'PAGER': '/bin/cat', 08:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:54 INFO - 'PWD': '/builds/slave/test', 08:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:54 INFO - 'SHELL': '/bin/bash', 08:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFoO11jCby/Listeners', 08:26:54 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:54 INFO - 'USER': 'cltbld', 08:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:54 INFO - 'XPC_FLAGS': '0x0', 08:26:54 INFO - 'XPC_SERVICE_NAME': '0', 08:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:54 INFO - Downloading/unpacking psutil>=3.1.1 08:26:54 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 08:26:54 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 08:26:54 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 08:26:54 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 08:26:54 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 08:26:54 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 08:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:26:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:58 INFO - Installing collected packages: psutil 08:26:58 INFO - Running setup.py install for psutil 08:26:58 INFO - building 'psutil._psutil_osx' extension 08:26:58 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 08:26:59 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 08:26:59 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 08:26:59 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 08:26:59 INFO - building 'psutil._psutil_posix' extension 08:26:59 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 08:26:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:26:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:26:59 INFO - ^ 08:26:59 INFO - 1 warning generated. 08:26:59 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 08:26:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:59 INFO - Successfully installed psutil 08:26:59 INFO - Cleaning up... 08:26:59 INFO - Return code: 0 08:26:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1033e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff319dae750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bed30>, '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 0x1030e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031b3be8>, '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.2ZgPZIDCJE/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.pFoO11jCby/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 08:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:26:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ZgPZIDCJE/Render', 08:26:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:59 INFO - 'HOME': '/Users/cltbld', 08:26:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:59 INFO - 'LOGNAME': 'cltbld', 08:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:59 INFO - 'MOZ_NO_REMOTE': '1', 08:26:59 INFO - 'NO_EM_RESTART': '1', 08:26:59 INFO - 'PAGER': '/bin/cat', 08:26:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:59 INFO - 'PWD': '/builds/slave/test', 08:26:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:59 INFO - 'SHELL': '/bin/bash', 08:26:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFoO11jCby/Listeners', 08:26:59 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:26:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:59 INFO - 'USER': 'cltbld', 08:26:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:59 INFO - 'XPC_FLAGS': '0x0', 08:26:59 INFO - 'XPC_SERVICE_NAME': '0', 08:26:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:27:00 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 08:27:00 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 08:27:00 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 08:27:00 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 08:27:00 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 08:27:00 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 08:27:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:27:02 INFO - Installing collected packages: mozsystemmonitor 08:27:02 INFO - Running setup.py install for mozsystemmonitor 08:27:02 INFO - Successfully installed mozsystemmonitor 08:27:02 INFO - Cleaning up... 08:27:03 INFO - Return code: 0 08:27:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:03 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 0x1033e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff319dae750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bed30>, '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 0x1030e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031b3be8>, '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.2ZgPZIDCJE/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.pFoO11jCby/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 08:27:03 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 08:27:03 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 08:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ZgPZIDCJE/Render', 08:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:03 INFO - 'HOME': '/Users/cltbld', 08:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:03 INFO - 'LOGNAME': 'cltbld', 08:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:03 INFO - 'MOZ_NO_REMOTE': '1', 08:27:03 INFO - 'NO_EM_RESTART': '1', 08:27:03 INFO - 'PAGER': '/bin/cat', 08:27:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:03 INFO - 'PWD': '/builds/slave/test', 08:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:03 INFO - 'SHELL': '/bin/bash', 08:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFoO11jCby/Listeners', 08:27:03 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:03 INFO - 'USER': 'cltbld', 08:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:03 INFO - 'XPC_FLAGS': '0x0', 08:27:03 INFO - 'XPC_SERVICE_NAME': '0', 08:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:03 INFO - Downloading/unpacking jsonschema==2.5.1 08:27:03 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 08:27:03 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 08:27:03 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 08:27:03 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 08:27:03 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 08:27:03 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 08:27:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:27:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:06 INFO - Downloading functools32-3.2.3-2.tar.gz 08:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:27:06 INFO - warning: no files found matching '*.txt' 08:27:06 INFO - no previously-included directories found matching 'build' 08:27:06 INFO - no previously-included directories found matching 'dist' 08:27:06 INFO - no previously-included directories found matching '.git*' 08:27:06 INFO - Installing collected packages: jsonschema, functools32 08:27:06 INFO - Running setup.py install for functools32 08:27:06 INFO - warning: no files found matching '*.txt' 08:27:06 INFO - no previously-included directories found matching 'build' 08:27:06 INFO - no previously-included directories found matching 'dist' 08:27:06 INFO - no previously-included directories found matching '.git*' 08:27:06 INFO - Successfully installed jsonschema functools32 08:27:06 INFO - Cleaning up... 08:27:06 INFO - Return code: 0 08:27:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:27:06 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')]} 08:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:06 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')]} 08:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:06 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 0x1033e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff319dae750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bed30>, '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 0x1030e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031b3be8>, '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.2ZgPZIDCJE/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.pFoO11jCby/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 08:27:06 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 08:27:06 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 08:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ZgPZIDCJE/Render', 08:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:06 INFO - 'HOME': '/Users/cltbld', 08:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:06 INFO - 'LOGNAME': 'cltbld', 08:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:06 INFO - 'MOZ_NO_REMOTE': '1', 08:27:06 INFO - 'NO_EM_RESTART': '1', 08:27:06 INFO - 'PAGER': '/bin/cat', 08:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:06 INFO - 'PWD': '/builds/slave/test', 08:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:06 INFO - 'SHELL': '/bin/bash', 08:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFoO11jCby/Listeners', 08:27:06 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:06 INFO - 'USER': 'cltbld', 08:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:06 INFO - 'XPC_FLAGS': '0x0', 08:27:06 INFO - 'XPC_SERVICE_NAME': '0', 08:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:27:06 INFO - Cleaning up... 08:27:06 INFO - Return code: 0 08:27:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:27:06 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')]} 08:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:06 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')]} 08:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:06 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 0x1033e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff319dae750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bed30>, '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 0x1030e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031b3be8>, '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.2ZgPZIDCJE/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.pFoO11jCby/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 08:27:06 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 08:27:06 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 08:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ZgPZIDCJE/Render', 08:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:06 INFO - 'HOME': '/Users/cltbld', 08:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:06 INFO - 'LOGNAME': 'cltbld', 08:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:06 INFO - 'MOZ_NO_REMOTE': '1', 08:27:06 INFO - 'NO_EM_RESTART': '1', 08:27:06 INFO - 'PAGER': '/bin/cat', 08:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:06 INFO - 'PWD': '/builds/slave/test', 08:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:06 INFO - 'SHELL': '/bin/bash', 08:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFoO11jCby/Listeners', 08:27:06 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:06 INFO - 'USER': 'cltbld', 08:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:06 INFO - 'XPC_FLAGS': '0x0', 08:27:06 INFO - 'XPC_SERVICE_NAME': '0', 08:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:07 INFO - Downloading/unpacking blobuploader==1.2.4 08:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:09 INFO - Downloading blobuploader-1.2.4.tar.gz 08:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:27:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:27:09 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 08:27:09 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 08:27:09 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 08:27:09 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 08:27:09 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 08:27:09 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 08:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:27:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:11 INFO - Downloading docopt-0.6.1.tar.gz 08:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:27:11 INFO - Installing collected packages: blobuploader, requests, docopt 08:27:11 INFO - Running setup.py install for blobuploader 08:27:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:27:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:27:11 INFO - Running setup.py install for requests 08:27:11 INFO - Running setup.py install for docopt 08:27:11 INFO - Successfully installed blobuploader requests docopt 08:27:11 INFO - Cleaning up... 08:27:12 INFO - Return code: 0 08:27:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:12 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 0x1033e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff319dae750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bed30>, '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 0x1030e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031b3be8>, '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.2ZgPZIDCJE/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.pFoO11jCby/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 08:27:12 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 08:27:12 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 08:27:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ZgPZIDCJE/Render', 08:27:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:12 INFO - 'HOME': '/Users/cltbld', 08:27:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:12 INFO - 'LOGNAME': 'cltbld', 08:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:12 INFO - 'MOZ_NO_REMOTE': '1', 08:27:12 INFO - 'NO_EM_RESTART': '1', 08:27:12 INFO - 'PAGER': '/bin/cat', 08:27:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:12 INFO - 'PWD': '/builds/slave/test', 08:27:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:12 INFO - 'SHELL': '/bin/bash', 08:27:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFoO11jCby/Listeners', 08:27:12 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:27:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:12 INFO - 'USER': 'cltbld', 08:27:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:12 INFO - 'XPC_FLAGS': '0x0', 08:27:12 INFO - 'XPC_SERVICE_NAME': '0', 08:27:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:27:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-xeXxez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:27:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-BIaxvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:27:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-QVsgVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:27:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-40Onof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:27:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-IcnS3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:27:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-veVmi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:27:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-d76ff7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:27:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-0jCVSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:27:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-q3NLwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:27:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-P9SPR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:27:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-_QsUgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:27:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-NKIrK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:27:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-4EWfek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:27:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-g0D8FM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-fQ_B9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:27:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-73NI_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:27:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-xkmc4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:27:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:27:14 INFO - Running setup.py install for manifestparser 08:27:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:27:14 INFO - Running setup.py install for mozcrash 08:27:14 INFO - Running setup.py install for mozdebug 08:27:14 INFO - Running setup.py install for mozdevice 08:27:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:27:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:27:14 INFO - Running setup.py install for mozfile 08:27:14 INFO - Running setup.py install for mozhttpd 08:27:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:27:15 INFO - Running setup.py install for mozinfo 08:27:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:27:15 INFO - Running setup.py install for mozInstall 08:27:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:27:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:27:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:27:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:27:15 INFO - Running setup.py install for mozleak 08:27:15 INFO - Running setup.py install for mozlog 08:27:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:27:15 INFO - Running setup.py install for moznetwork 08:27:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:27:15 INFO - Running setup.py install for mozprocess 08:27:16 INFO - Running setup.py install for mozprofile 08:27:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:27:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:27:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:27:16 INFO - Running setup.py install for mozrunner 08:27:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:27:16 INFO - Running setup.py install for mozscreenshot 08:27:16 INFO - Running setup.py install for moztest 08:27:16 INFO - Running setup.py install for mozversion 08:27:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:27:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:27:16 INFO - Cleaning up... 08:27:16 INFO - Return code: 0 08:27:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27:16 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')]} 08:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:16 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')]} 08:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:16 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 0x1033e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff319dae750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bed30>, '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 0x1030e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031b3be8>, '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.2ZgPZIDCJE/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.pFoO11jCby/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 08:27:16 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 08:27:16 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 08:27:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ZgPZIDCJE/Render', 08:27:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:16 INFO - 'HOME': '/Users/cltbld', 08:27:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:16 INFO - 'LOGNAME': 'cltbld', 08:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:16 INFO - 'MOZ_NO_REMOTE': '1', 08:27:16 INFO - 'NO_EM_RESTART': '1', 08:27:16 INFO - 'PAGER': '/bin/cat', 08:27:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:16 INFO - 'PWD': '/builds/slave/test', 08:27:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:16 INFO - 'SHELL': '/bin/bash', 08:27:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFoO11jCby/Listeners', 08:27:16 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:27:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:16 INFO - 'USER': 'cltbld', 08:27:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:16 INFO - 'XPC_FLAGS': '0x0', 08:27:16 INFO - 'XPC_SERVICE_NAME': '0', 08:27:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:27:17 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Yv5c8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:27:17 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)) 08:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:27:17 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-QvQ54u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:27:17 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)) 08:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:27:17 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ZkwFtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:27:17 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)) 08:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:27:17 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-nPGnJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:27:17 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-K0eZw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:27:17 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)) 08:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:27:17 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-3Jvbqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:27:17 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)) 08:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:27:17 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-V4qAqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:27:17 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)) 08:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:27:17 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-vAQAXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:27:17 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)) 08:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:27:17 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-z3gRpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:27:18 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)) 08:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:27:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-9lV6qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:27:18 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)) 08:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:27:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-CK_zZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:27:18 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)) 08:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:27:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-vNC9Sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:27:18 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)) 08:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:27:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-tU0a4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:27:18 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)) 08:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:27:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-7QXPmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:27:18 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)) 08:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-A17vOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:18 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)) 08:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:27:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-yjxsWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:27:18 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)) 08:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:27:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-jpswM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:27:18 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)) 08:27:18 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)) 08:27:18 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)) 08:27:18 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)) 08:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:27:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:27:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:21 INFO - Downloading blessings-1.6.tar.gz 08:27:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:27:21 INFO - Installing collected packages: blessings 08:27:21 INFO - Running setup.py install for blessings 08:27:21 INFO - Successfully installed blessings 08:27:21 INFO - Cleaning up... 08:27:21 INFO - Return code: 0 08:27:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:27:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:22 INFO - Reading from file tmpfile_stdout 08:27:22 INFO - Current package versions: 08:27:22 INFO - blessings == 1.6 08:27:22 INFO - blobuploader == 1.2.4 08:27:22 INFO - docopt == 0.6.1 08:27:22 INFO - functools32 == 3.2.3-2 08:27:22 INFO - jsonschema == 2.5.1 08:27:22 INFO - manifestparser == 1.1 08:27:22 INFO - mozInstall == 1.12 08:27:22 INFO - mozcrash == 1.0 08:27:22 INFO - mozdebug == 0.1 08:27:22 INFO - mozdevice == 0.49 08:27:22 INFO - mozfile == 1.2 08:27:22 INFO - mozhttpd == 0.7 08:27:22 INFO - mozinfo == 0.9 08:27:22 INFO - mozleak == 0.1 08:27:22 INFO - mozlog == 3.4 08:27:22 INFO - moznetwork == 0.27 08:27:22 INFO - mozprocess == 0.25 08:27:22 INFO - mozprofile == 0.28 08:27:22 INFO - mozrunner == 6.13 08:27:22 INFO - mozscreenshot == 0.1 08:27:22 INFO - mozsystemmonitor == 0.3 08:27:22 INFO - moztest == 0.8 08:27:22 INFO - mozversion == 1.4 08:27:22 INFO - psutil == 3.1.1 08:27:22 INFO - requests == 1.2.3 08:27:22 INFO - wsgiref == 0.1.2 08:27:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27: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')]} 08:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27: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')]} 08:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:22 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 0x1033e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff319dae750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bed30>, '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 0x1030e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031b3be8>, '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.2ZgPZIDCJE/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.pFoO11jCby/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 08:27:22 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 08:27:22 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 08:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ZgPZIDCJE/Render', 08:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:22 INFO - 'HOME': '/Users/cltbld', 08:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:22 INFO - 'LOGNAME': 'cltbld', 08:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:22 INFO - 'MOZ_NO_REMOTE': '1', 08:27:22 INFO - 'NO_EM_RESTART': '1', 08:27:22 INFO - 'PAGER': '/bin/cat', 08:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:22 INFO - 'PWD': '/builds/slave/test', 08:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:22 INFO - 'SHELL': '/bin/bash', 08:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFoO11jCby/Listeners', 08:27:22 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:22 INFO - 'USER': 'cltbld', 08:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:22 INFO - 'XPC_FLAGS': '0x0', 08:27:22 INFO - 'XPC_SERVICE_NAME': '0', 08:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:22 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)) 08:27:22 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)) 08:27:22 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)) 08:27:22 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)) 08:27:22 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)) 08:27:22 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)) 08:27:22 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)) 08:27:22 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)) 08:27:22 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)) 08:27:22 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)) 08:27:22 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)) 08:27:22 INFO - Cleaning up... 08:27:22 INFO - Return code: 0 08:27:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:27: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')]} 08:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27: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')]} 08:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:22 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 0x1033e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff319dae750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031bed30>, '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 0x1030e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031b3be8>, '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.2ZgPZIDCJE/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.pFoO11jCby/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 08:27:22 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 08:27:22 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 08:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ZgPZIDCJE/Render', 08:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:22 INFO - 'HOME': '/Users/cltbld', 08:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:22 INFO - 'LOGNAME': 'cltbld', 08:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:22 INFO - 'MOZ_NO_REMOTE': '1', 08:27:22 INFO - 'NO_EM_RESTART': '1', 08:27:22 INFO - 'PAGER': '/bin/cat', 08:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:22 INFO - 'PWD': '/builds/slave/test', 08:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:22 INFO - 'SHELL': '/bin/bash', 08:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFoO11jCby/Listeners', 08:27:22 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:22 INFO - 'USER': 'cltbld', 08:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:22 INFO - 'XPC_FLAGS': '0x0', 08:27:22 INFO - 'XPC_SERVICE_NAME': '0', 08:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:27:22 INFO - Cleaning up... 08:27:22 INFO - Return code: 0 08:27:22 INFO - Running post-action listener: _resource_record_post_action 08:27:22 INFO - Running post-action listener: _start_resource_monitoring 08:27:22 INFO - Starting resource monitoring. 08:27:22 INFO - [mozharness: 2017-04-26 15:27:22.691514Z] Finished create-virtualenv step (success) 08:27:22 INFO - [mozharness: 2017-04-26 15:27:22.692531Z] Running install step. 08:27:22 INFO - Running pre-action listener: _resource_record_pre_action 08:27:22 INFO - Running main action method: install 08:27:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:22 INFO - Reading from file tmpfile_stdout 08:27:22 INFO - Detecting whether we're running mozinstall >=1.0... 08:27:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:27:23 INFO - Reading from file tmpfile_stdout 08:27:23 INFO - Output received: 08:27:23 INFO - Usage: mozinstall [options] installer 08:27:23 INFO - Options: 08:27:23 INFO - -h, --help show this help message and exit 08:27:23 INFO - -d DEST, --destination=DEST 08:27:23 INFO - Directory to install application into. [default: 08:27:23 INFO - "/builds/slave/test"] 08:27:23 INFO - --app=APP Application being installed. [default: firefox] 08:27:23 INFO - mkdir: /builds/slave/test/build/application 08:27:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:27:37 INFO - Reading from file tmpfile_stdout 08:27:37 INFO - Output received: 08:27:37 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:27:37 INFO - Running post-action listener: _resource_record_post_action 08:27:37 INFO - [mozharness: 2017-04-26 15:27:37.939854Z] Finished install step (success) 08:27:37 INFO - [mozharness: 2017-04-26 15:27:37.940017Z] Running run-tests step. 08:27:37 INFO - Running pre-action listener: _resource_record_pre_action 08:27:37 INFO - Running main action method: run_tests 08:27:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:27:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:27:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:27:37 INFO - 2017-04-26 08:27:37.954 screenresolution[3297:311967] starting screenresolution argv=screenresolution get 08:27:37 INFO - 2017-04-26 08:27:37.957 screenresolution[3297:311967] Display 0: 1600x1200x32@60 08:27:37 INFO - 2017-04-26 08:27:37.963 screenresolution[3298:311969] starting screenresolution argv=screenresolution list 08:27:37 INFO - Available Modes on Display 0 08:27:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:27:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:27:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:27:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:27:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:27:38 INFO - Intel Iris: 08:27:38 INFO - Chipset Model: Intel Iris 08:27:38 INFO - Type: GPU 08:27:38 INFO - Bus: Built-In 08:27:38 INFO - VRAM (Dynamic, Max): 1536 MB 08:27:38 INFO - Vendor: Intel (0x8086) 08:27:38 INFO - Device ID: 0x0a2e 08:27:38 INFO - Revision ID: 0x0009 08:27:38 INFO - Displays: 08:27:38 INFO - Display: 08:27:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:27:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:27:38 INFO - Display Serial Number: 1600x1200 60 08:27:38 INFO - Main Display: Yes 08:27:38 INFO - Mirror: Off 08:27:38 INFO - Online: Yes 08:27:38 INFO - Rotation: Supported 08:27:38 INFO - Return code: 0 08:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:27:38 INFO - Python 2.7.3 08:27:38 INFO - Return code: 0 08:27:38 INFO - grabbing minidump binary from tooltool 08:27:38 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')]} 08:27:38 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 0x1031bed30>, '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 0x1030e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031b3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:27:38 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 08:27:38 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 08:27:38 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 08:27:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:27:38 INFO - Return code: 0 08:27:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:27:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:27:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:27:38 INFO - ENV: RUST_BACKTRACE is now 1 08:27:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:27:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--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 08:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0079 --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 08:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ZgPZIDCJE/Render', 08:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:38 INFO - 'HOME': '/Users/cltbld', 08:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:38 INFO - 'LOGNAME': 'cltbld', 08:27:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:27:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:38 INFO - 'MOZ_NO_REMOTE': '1', 08:27:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:27:38 INFO - 'NO_EM_RESTART': '1', 08:27:38 INFO - 'PAGER': '/bin/cat', 08:27:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:38 INFO - 'PWD': '/builds/slave/test', 08:27:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:38 INFO - 'RUST_BACKTRACE': '1', 08:27:38 INFO - 'SHELL': '/bin/bash', 08:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pFoO11jCby/Listeners', 08:27:38 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 08:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:38 INFO - 'USER': 'cltbld', 08:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:38 INFO - 'XPC_FLAGS': '0x0', 08:27:38 INFO - 'XPC_SERVICE_NAME': '0', 08:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--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 08:27:38 INFO - mozversion application_buildid: 20170426073340 08:27:38 INFO - mozversion application_changeset: c19247505a48b4353ba4f4115daa88181d66108e 08:27:38 INFO - mozversion application_display_name: Firefox 08:27:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:27:38 INFO - mozversion application_name: Firefox 08:27:38 INFO - mozversion application_remotingname: firefox 08:27:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:27:38 INFO - mozversion application_vendor: Mozilla 08:27:38 INFO - mozversion application_version: 54.0 08:27:38 INFO - mozversion platform_buildid: 20170426073340 08:27:38 INFO - mozversion platform_changeset: c19247505a48b4353ba4f4115daa88181d66108e 08:27:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:27:38 INFO - mozversion platform_version: 54.0 08:27:38 INFO - using testdate: 1493220458 08:27:38 INFO - actual date: 1493220458 08:27:38 INFO - starting webserver on 'localhost:64624' 08:27:38 INFO - SUITE-START | Running 2 tests 08:27:38 INFO - TEST-START | dromaeo_css 08:27:38 INFO - operating with platform_type : mac_ 08:27:38 INFO - Initialising browser for dromaeo_css test... 08:27:38 INFO - TEST-INFO | started process 3308 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpzhlLa6/profile http://localhost:64624/getInfo.html) 08:27:40 INFO - PROCESS | 3308 | __metrics Screen width/height:1600/1200 08:27:40 INFO - PROCESS | 3308 | colorDepth:24 08:27:40 INFO - PROCESS | 3308 | Browser inner width/height: 1024/689 08:27:40 INFO - PROCESS | 3308 | __metrics 08:27:41 INFO - PROCESS | 3308 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:27:41 INFO - PROCESS | 3308 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:27:41 INFO - TEST-INFO | 3308: exit 0 08:27:41 INFO - Browser initialized. 08:27:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:27:41 INFO - TEST-INFO | started process 3312 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpzhlLa6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:53 INFO - PROCESS | 3312 | RSS: Main: 165314560 08:27:53 INFO - PROCESS | 3312 | 08:30:57 INFO - PROCESS | 3312 | Cycle 1(1): loaded http://localhost:64624/tests/dromaeo/cssquery-dojo.html (next: http://localhost:64624/tests/dromaeo/cssquery-ext.html) 08:30:59 INFO - PROCESS | 3312 | RSS: Main: 370163712 08:30:59 INFO - PROCESS | 3312 | 08:34:02 INFO - PROCESS | 3312 | Cycle 1(1): loaded http://localhost:64624/tests/dromaeo/cssquery-ext.html (next: http://localhost:64624/tests/dromaeo/cssquery-jquery.html) 08:34:03 INFO - PROCESS | 3312 | RSS: Main: 296632320 08:34:03 INFO - PROCESS | 3312 | 08:37:05 INFO - PROCESS | 3312 | Cycle 1(1): loaded http://localhost:64624/tests/dromaeo/cssquery-jquery.html (next: http://localhost:64624/tests/dromaeo/cssquery-mootools.html) 08:37:06 INFO - PROCESS | 3312 | RSS: Main: 282632192 08:37:06 INFO - PROCESS | 3312 | 08:40:08 INFO - PROCESS | 3312 | Cycle 1(1): loaded http://localhost:64624/tests/dromaeo/cssquery-mootools.html (next: http://localhost:64624/tests/dromaeo/cssquery-prototype.html) 08:40:09 INFO - PROCESS | 3312 | RSS: Main: 275525632 08:40:09 INFO - PROCESS | 3312 | 08:43:13 INFO - PROCESS | 3312 | Cycle 1(1): loaded http://localhost:64624/tests/dromaeo/cssquery-prototype.html (next: http://localhost:64624/tests/dromaeo/cssquery-yui.html) 08:43:13 INFO - PROCESS | 3312 | RSS: Main: 263520256 08:43:13 INFO - PROCESS | 3312 | 08:46:17 INFO - PROCESS | 3312 | Cycle 1(1): loaded http://localhost:64624/tests/dromaeo/cssquery-yui.html (next: http://localhost:64624/tests/dromaeo/cssquery-dojo.html) 08:46:17 INFO - PROCESS | 3312 | RSS: Main: 304353280 08:46:17 INFO - PROCESS | 3312 | 08:46:17 INFO - PROCESS | 3312 | __start_tp_report 08:46:17 INFO - PROCESS | 3312 | _x_x_mozilla_page_load 08:46:17 INFO - PROCESS | 3312 | _x_x_mozilla_page_load_details 08:46:17 INFO - PROCESS | 3312 | |i|pagename|runs| 08:46:17 INFO - PROCESS | 3312 | |0;dojo.html;3227.096413004359;3494.7903125812454;3496.1609213788697;3543.1319326764947;3556.164301389173;6142.109394137853;6167.876642467148;6197.039458883869;6198.597091189075;6209.223847019122;6141.6622085785375;6243.71903264353;6251.59364641298;6258.2490101187805;6267.780627678032;5456.672599644025;5492.533134683536;5527.778888844441;5532.170174473821;5596.776128954857;5347.465253474641;5368.033753924292;5591.916121258185;5595.608307418483;5598.664080155183;5428.267183930158;5496.4503549645115;5504.2018907258425;5512.255845460872;5524.4199359067325;5529.225908372831;5536.446355364472;5540.667559946376;5541.168824676291;5556.972215138939;5397;5468.808591699271;5496.80761173361;5505.807296744635;5525.889482210374;5952.285725712942;6020.367861374581;6087.695615219265;6135.846603834895;6141.600795948294;6555.04951781989;6577.736890524373;6581.2760596334365;6582.769603063918;6597.868042639168;6606.504512161559;6650.700718467632;6659.067730517731;6661.733530658767;6665.066890635315;6116.724747386378;6138.094643526033;6172.321044685081;6282.403171698681;6325.5255855811;6576.506761992774;6665.266820649725;6674.766383176662;6747.190337159573;6774.796756097325;6479.902801457982;6490.350964903472;6491.772787952399;6499.350064993463;6519.576227545194;6302.1177035215105;6448.161738973997;6585.703643336062;6596.670166491656;6604.603723776589;6351.904721429182;6393.552451328455;6421.614703117828;6424.293327733945;6456.160699109179;6277.18396608438;6292.05619157121;6307.306196318401;6321.146645202839;6561;5184.507471790174;5219.086659834514;5252.264682944391;5264.05247055526;5280.260763493114;4771.976140119277;4774.928376074362;4792.329073929653;4815.903681926342;4843.975780121077;6268.780592679325;6286.214223222098;6291.433770960635;6295.464885484694;6297.086922396227;6332.4934005279465;6389.9680501597195;6546.738130474823;6562.212534495891;6666.966665166643;6258.249010118815;6266.342034086447;6281.905771413432;6286.277078135981;6287.151234583364;5733.140028995684;5750.453706897838;5783;5799.536037117021;5851.093080572518;6495.415412612888;6562.573432727048;6635.137432133792;6774.627395493098;6827.897581536182;6583.374579414948;6610.471162306908;6630.30381809903;6633.568818026813;6634.436072933661;6722.9663851680425;6757.425618822455;6761.966190169018;6766.560173588701;6782.016607591971;6279.497640188682;6314.052892066226;6498.285188629153;6551.770688026087;6572.244191917991;5740.311162660508;6368.267649220399;6409.9679501602195;6416.743330266737;6490.3185165558825;6396.584222025554;6413.7113829876835;6433.970564709624;6440.967795160994;6442.484601231984;6379.457746091634;6414.550981431442;6438.967805160944;6443.548951573345;6449.9355006451215;6185.597936134137;6325.810225693236;6326.525510586633;6335.081413195153;6335.588186767845;6286.371362863677;6318.147050148171;6348.93651063502;6440.516961228021;6490.8052758417325;6163.044728067157;6170.81487555374;6228.314885362516;6241.843953901189;6298.968505157445 08:46:17 INFO - PROCESS | 3312 | |1;ext.html;804.6017221475369;824.5918270456124;905.8278927003864;906.895706993696;915.890093188817;37371.813140934326;41273.968150796245;41419.75740727776;41534.58465415353;41669.58330416695;43364.13271734571;43485.78257108718;43553.564464355426;43638.34542481865;43640;7887.723929662463;8029.317508011826;9622.566984485697;9791.608335666564;9815.50922453878;8012.318952889012;8070.152633973436;8107.513549187068;11759.7648047039;11916.225445346025;11972.760544789098;12000.33998130107;12034.217775844541;12066.336351500664;12073.818892716572;11953.940230298793;11978.580749673763;11991.700207494796;11991.820122698211;12012.219205751599;11520.078393728481;11523.366214858179;11540.019098376648;11543.826842597367;11550.133739969537;40076.799616001736;40139;40158.196836063405;40283.59716402828;40344.39483407751;4053.250148722496;4070.735402198877;4110.403991421257;4116.5060192776755;4129.318662420697;28609.427811443653;28682.554204098396;30654.54018189729;30901.690983090106;31037.844810776027;3270.4440245158144;3288.1615188126875;3308.67652938824;3422.435298175798;3427.0404286799735;353074;358684;358772.4122758765;359506;360359;43814.56185438169;44582.77708611501;46823.82940426517;53853.73073134609;54198.45801542013;55618.443815561324;56623.71688141533;59698.50753731192;59721;59892.401075989554;12866.806997895039;15649.139297338528;15694.979826311253;15717.113946326514;15749.921250393674;13240;13281.070325077151;13301;13305.93347033278;13309.93345033288;12487.93756031214;12507.687307817378;12566;12613.243205407522;12663.050271229695;5489.64317319373;5516.586256030814;5523.640963337451;5530.253415788817;5532.1232958861165;1097.5006372100675;1147.5926046253626;1173.20808454293;1178.4755783676183;1225;27248.31879202996;27836.582451263246;27843.443131137265;27984.160475185778;28144.43711125766;1281.6731733407921;1281.8910392616733;1294.3851670456459;1337.9732405351838;1339.0760375340983;12514.749705005848;13879.791803122962;14251.50119745804;14253.038168546345;14583.416663333348;473185;473978;474206;474250;475248.623756879;57196.71401642965;57281.71359143178;57440;57447.71276143593;57517.712411438515;1450.3690894460733;1460.5983354577577;1474.1597289544857;1506.6835964447368;1508.2383396384755;26298.474030519665;27544.17367478979;28090.57864131999;28233.858830705714;28253.29366765765;38773.80613096916;38814;39036.41445378265;39046.60953390544;39050.609493904696;396212;396246;396850;397339;398937;24962.87518562468;25148.74851251464;26297.07960221383;26568.468630626892;30041.399172016;32165.678343216267;37989.81005094957;38673.80663096667;38738.80630596829;39736;23353.88323058374;26663;26871.865640671673;29250.853745731136;29368.118956431343;27856.88572457079;27872.860635697503;28041.01856435015;28217.858910705316;29105;33640.831795840866;33659;33696.49455258222;42228.94427639333;43146.568534314254;33705;39310.41034384429;41835.37246941359;42300.73097807071;43270.78364608157;32113.8394308027;33012.339753205284;33017.67929282802;33060;33249.833750831094 08:46:17 INFO - PROCESS | 3312 | |2;jquery.html;379.56350197273133;422.37488516994864;427.9786010699464;431.624486696574;459.79539105098223;18405.53986150347;21330.36008919731;22930.197443089473;23143.652845207293;23471;20095.698564521543;20372.083256253467;22751;24135.51728965424;24462.633060504064;5852.678102704371;6758.290379510155;7013.3337332953415;7198.4601154913325;7270.091238595176;7097.716091356339;7143.071400717899;7223.241559636215;7245.963770181168;7262.745803896864;6861.656917154122;7136.000959865623;7194.676239569206;7211.206767255598;7222.241664625218;6855.280195579492;7085.326893945067;7139.214686384494;7196.676149573282;7213.531120477179;6958.756443524503;6980.7905762827195;6982.546134501241;6983.89524157138;7001.544899581511;19652.50868728279;28228.15315540537;28397.432051359065;28516.857415712995;28756.281092972633;2603.3621762668267;2740.657417822772;3010.6086208792935;3016.08009557085;3051.7406020488284;7660.5403675779635;7728.072631284282;12785.552505662257;15622.843771562253;17540.649187016188;1956.7064940259074;2080.4070839810583;2105.221068204774;2197.7142971413773;2283.5204607032542;91874.6031821802;100426;118362;139368;143260;22180.334589962327;22312.665310020362;22337.88310584497;22482.21312254096;22548.549029019658;36103;36426.27147457089;36876.446853297224;36920.81539592285;37002;11319.37743424103;11534.480948357177;11748.412579370997;11773.646790596296;11990;7645.5794931279315;9432.339736218537;9458.810823783486;9598.32811703188;9658.661946831828;10576.682699519026;10921.563137474572;10945.124390048777;11017.394043327695;11059.953908526948;3374.3420033093803;3527.8588856445967;3817.1983883384246;4039.2527382434346;4045.696572757055;1018.144105783285;1020.5815615597569;1089.1559041742712;1131.179894576442;1153.7000379901285;23235.3029409118;23412.946417411258;23512.412189695053;23907.282781516584;24190;912.771807048238;1007.4207330784828;1144.547903578082;1170.4206417823232;1179.2452830188686;11859.762804743857;12234.858899692517;12416.379181040911;12478.81281780774;12488.562900298446;673508;760732.1963390259;762835;771985;791270;130076;131616.3419182898;137405;175293;177957;1249.4502418935822;1251.9687007824696;1302.7003789128364;1307.7776777947772;1318.2815365625756;20425.795742042388;20999.685004724637;21208.993403042972;21277.574448510633;21474.463138421663;67096;67187;67901.64196715939;68377.65811170913;69119.65440172968;99995;100265;100891;101539;103300.48349758203;11866.406679666155;12003.75992480163;12221.28901953745;12332.753344933231;12453.754624537474;13679.79480307816;13687.248469596716;13808.93095534556;14052.78920816209;14279.21464319431;11592;11702.180847340604;11935.76128477443;11939.04487641004;12068.034557235225;10910.945445272722;10952.78094438091;11043.83434248503;11373.829392558953;11409.429528523375;9539.618415263312;11681.240719353214;11849.229800062969;12055.698607534881;12113.81829272544;11863.71223251678;11922.940385298365;12172.208806427909;12211.206271592673;12272.938635306766;9351.438913665203;9514;11797.941010295237;11937.582184623496;12042.578509752468 08:46:17 INFO - PROCESS | 3312 | |3;mootools.html;1601.574598607239;1615.2004757644968;1635.8037035555735;1642.4579888636745;1648.8928219665722;10851.51168197431;11508.597199098032;11520.135989800778;11534.884651153487;11563.190576659626;11206.607768728096;11376.658700239006;11685.532578696842;11730.7653846923;11743.177977541576;2457.3733697907055;2523.49530093981;2525.6337831014494;2526.68416447944;2533.3160046787357;2444.0346063304983;2458.1887976967646;2497.0386401235564;2501.2996361018945;2505.5991041433376;2451.1053465485147;2463.1379017343966;2476.913308034219;2488.1167185649106;2491.8504889706587;2400.279916025203;2444.4744379958215;2453.337598848301;2467.938301542458;2468.4816188600325;2417.601095819188;2441.2554170977846;2451.142100264911;2453.852768833876;2456.361346050022;11157.27477713946;11390.974812266935;11394.202405831595;11397.145214108976;11423.314601123959;5909.940900591025;6094.451499365034;6100.450959413674;6107.29766076898;6109.4501494865235;3534.1871369584883;3616.5117709109195;3621.7645853019735;3680.6319368063246;3691.70466362693;1197.598804400527;1222.6821026533075;1222.712662524306;1265.329375431023;1278.9424475898606;11028.558857645685;13839.723205535933;14195.787063194164;15703;16119.032858028439;4878.219484882402;5021.14640511114;5056.494350564988;5084.694918304914;5087.720175390389;12209.938950305192;13258.53595124166;13273.402696878664;13312.534061307808;13318.933405332911;4820.662553621213;5120.92318615221;6096.573239873255;6135.141080248769;6139.754409823557;5147.279380886679;5310.2831117798605;5390.110631745718;5399;5400.459954004568;4161.542230354658;4170.778887529093;4242.17277630859;4269.743815371087;4299.398084268205;1136.8740455348552;1147.3345459633392;1153.1005815463952;1167.1888037813808;1168.2406435816788;938.2775263047415;969.2633598465217;975.7170420578095;983.4246965525105;996.5549952568804;6699.6315202663345;6737.29258427858;6738.831529211711;6818.249992500821;6893.7931862044215;864.4208380385157;967.8257913575483;972.5769290358717;990.6928852055742;1037.2894567221326;3007.624046994126;3012.051203870774;3228.935421291561;3279.1942835532504;3370.0563842124243;13019.088663793444;13792.517261895786;14127.576172714835;14129.152250864981;14138.71722565543;13752.518661846787;13970.720585588231;14071.507497237548;14177.645558861112;14201.644958876112;8756.781080472912;10364.429956352322;10558.04977552024;10623.990720881658;10690.251682382313;6527.412532872065;6564.868702625825;6633.474300910914;6675.23234828001;6723.428508576826;12363.505459781509;12381.319027453215;12413.627591172279;12528.060395470195;12602;12698.238105713686;12804;12816.551420700604;12984.545540906402;12994.090413670952;9395.32330114053;9410.482423466776;9431.717048488556;9562.18721408688;9566.234701223746;10407.219458540489;10419.791604168026;10542.26204165701;10574.471276436301;10611.469426528489;8958.328125390492;8989.370744047854;9055.18503334703;9112.95443522778;9121.908780912372;8677.002144753435;8757.693480728143;8815.338849586178;8872.73381798547;8910.376273660782;7868.960655196687;8026.43814932949;8056.7180148694515;8228.958855205925;8264.752057438287;5941.197938278277;5952.58331916779;6002.489788368038;6122.142899994094;6184.196054512884;5942.73257703413;5955.612885162451;6144.262688477412;6224.533160012927;6252.781152659635 08:46:17 INFO - PROCESS | 3312 | |4;prototype.html;331.71141107236707;377.155172413793;391.9960800391995;393.9684825213983;397.93434083376246;4423.424954755881;4707.963363630456;5253.8441542860555;5254.7635356408955;5262.631615786897;4358.825646974117;4651.697524693083;4957.141072097963;5149.794008239666;5195.506426889449;4322.697411181219;4328.523862375152;4338.370936214247;4344.9348259776125;4356.65146788257;3636.818159092048;3825.8469661213517;4331.436913201295;4367.934480982772;4375.6499480041675;3404.557407537029;3577.069961809935;3765.9623403765886;3964.949288438566;4334.566543345656;4208.852690155861;4242.902681042825;4250.681198910063;4252.425922500484;4279.379489973952;3223.871045158191;3935.429362742415;3949.980250098731;3965.266425711253;3966.504186976628;4740.668153229275;4993.725345106018;5078.898422031576;5141.100307446182;5245.770547517328;4630.652701047435;4965.726885021322;4967.975160124176;4982;5018.397792264952;4492.3710680504755;5264.368275806928;5514.283143191359;5551.250581171531;5556.027440380107;4025.19496100781;4135.069609337905;4410.7794610269675;4450.554944505556;4458.5318541553315;4594.793234304498;5196.882670225919;5511.889762204773;5568.52667523257;5753.913691294634;4361.236783562864;4391.341298805205;4403.361512580658;4535.707323412811;4589.5181005994555;4649.885400698071;4667.579917807414;4668.533146685372;4706.647001474903;4721.5986641135205;4343.522212556616;4618.49196588375;4938.827141050046;4977.97951419958;4983.127952608279;4969.776360063805;5219.2953951216095;5269.499397557226;5468.48049435303;5486.396496385474;1440.6542429816768;1476.247113971882;1564.5228205397236;1567.2633862084801;1577.7238983177897;926.6756635177634;1109.7891400633853;1168.6735555144971;1174.9836391521274;1179.8820117988132;4646;4646.6747327686735;4669.987857831679;4961.057399094233;5157.613179011589;5639.746211420496;5655.802046928337;5664.912622620682;5673.6028478006965;5695.914561281584;4773.689710168828;4977.8302099006705;4982.377202849644;5111.131107711698;5118.667286626357;2582.9354266143123;2593.5590949538623;2784.9025284115364;2926.692697266756;2956.51217549102;5351.127105513039;5617.32592088952;5851.385604511465;5893.675847828411;5894.557908156906;5167.209706758384;5312.017276803804;5363.517283444508;5540.612157148961;5631.211630371751;4919.926201106986;5070.526689217898;5180.948190518122;5852.4147585241135;5900.232969713824;5310.495502927216;5323.790626889798;5704.771809127588;5710.716338105689;5726.68286294163;5010.799568017239;5635;5657.264555607745;5731.914021289601;5738.4421658571955;5273.499017593323;5593.188987596857;5711.143328500758;5745.569082318759;5926.259217597801;3999.460072890123;4535.206338890747;4541.093700032048;4563.7489938052395;4587.375972981441;5191.584673226208;5321.920171197357;5553.333599968029;5697.376247769366;5753.3958934311295;4883.8290659826735;5258.370814592704;5480.314960629921;5513.889722205614;5537.141743029837;5302.628815982845;5486.533644640091;5515.365732940602;5524.14375771756;5597.44025597437;4643.303504474356;5052.823151189691;5085.516875896784;5443.998660984253;5471.8084867029465;4717.9056418872115;4870.683405578768;5413.56691464674;5463.562914966873;5537.972310138423;4839.112496378612;5199.232261031268;5404.621676482766;5411.269478620493;5420.834520578094 08:46:17 INFO - PROCESS | 3312 | |5;yui.html;777.0170734021464;792.698774465703;830.8089139497919;888.4447220487195;893.7988952485689;16024.919875400621;17712.64574708505;17731.911340443312;17752.201150948207;17789.11054447276;16128.516144515654;16180.75728864068;16367.59081022975;16375.59061023475;16390.508284751446;972.7568107973007;975.5805003848342;977.6285011695563;978.2760757039775;991.5092029445399;894.2979760887705;995.6011803416212;1019.3578045831116;1036.7874585709949;1038.2939601071268;1065.4938904020605;1065.6003998500562;1067;1068.1935138970066;1071.6838532632892;1062.4581463453694;1063.7021633942431;1064.1433645915035;1065.9979619157966;1066.0671912076932;792.1919641965163;792.7304716396395;793.0919097633235;793.1077537770009;794.06697130871;17547.385841495485;17928.193231304624;18000.279988800565;18146.90926545372;18266;14676;14744.410223591043;14910.776338354934;14952.925235373754;15160.393584256617;11936.582219622358;11940;12296.262224266573;12472.937635311766;12892.162009469355;3750.7374483786148;3800.9809950950344;3984.561698213194;4114.691398145151;4121.031557583995;109521;115826;117574.41212793882;118077.40961295138;121305;11062.506561614078;11469.88530114705;11503.252288601214;11638.243514171552;11640.941795291139;23600.173993910474;23989.160379386638;24008.51982960331;24017.759822401902;24031.399215019414;8185.263326300662;8225.917740822635;8226.629801658939;8278.420704506158;8337.207965243293;4653.464851542116;4668.463126740468;4697.436307643105;4709.458412282563;4781.593564546983;3368.7473439492137;3447.517347571342;3470.5661792275964;3474.496198051319;3475.669811367916;624.2010226909563;646.6734299178885;647.6696884588894;660.5442244851133;668.9464842812563;671.5265737655039;703.3880523944201;708.6279703155884;722.9674664639998;771.5255118102326;10437.739056523647;10897.891021089847;10949.343039417661;11048.668539943814;11221.438928053727;731.1336066760905;743.8990294364371;760.1828034862544;768.2267016071976;773.9961300193463;4607.963208278111;4929.3345398371475;5147;5255.421903590602;5266.183741520071;106753;107942.92057079329;109279.45360273148;112595.43702281437;113226.86773132328;72793.27206727865;92535.53732231431;93882.0611793887;95952;96733.5163324193;80636.59681701788;80687;82599.5870020658;83450.58274708588;84011.99999999878;10128.446208797257;10243.7439064024;10296.639617613348;10340.276180667583;10428.217883658604;47271;52872.471275286756;52963;54447.45552544424;55411;52729;68146;69311.30688693048;70244;70878.93681594677;11538.711532211762;11569.132315076235;11606.187566870576;11861.288322700666;12069.155159139127;11835.349055802013;12514.561990330294;13126.40931158081;13522.729545409233;13556.051076424556;12139;12149.392530373623;12509.624711258677;12832.29422381778;12897.226166430044;11872;11878.227915185485;12319.876801231872;12663.353764010988;12674;12093.153479256367;12128.514859405524;12136.211146275464;12201.20692155007;12250.326232057323;6994.895076573957;8108.554029528196;8538.103499132501;8723.171298726611;8850.468971861708;9672.93597704266;10203.540840662337;10356.53395597215;10369.325993810378;10406.167506599606 08:46:17 INFO - PROCESS | 3312 | __end_tp_report 08:46:17 INFO - PROCESS | 3312 | __start_cc_report 08:46:17 INFO - PROCESS | 3312 | _x_x_mozilla_cycle_collect,2333 08:46:17 INFO - PROCESS | 3312 | __end_cc_report 08:46:17 INFO - PROCESS | 3312 | __startTimestamp1493221577290__endTimestamp 08:46:17 INFO - PROCESS | 3312 | 08:46:17 INFO - PROCESS | 3312 | ------- Summary: start ------- 08:46:17 INFO - PROCESS | 3312 | Number of tests: 6 08:46:17 INFO - PROCESS | 3312 | 08:46:17 INFO - PROCESS | 3312 | [#0] dojo.html Cycles:165 Average:6083.91 Median:6295.46 stddev:666.82 (10.6%) stddev-sans-first:630.08 08:46:17 INFO - PROCESS | 3312 | Values: 3227.1 3494.8 3496.2 3543.1 3556.2 6142.1 6167.9 6197.0 6198.6 6209.2 6141.7 6243.7 6251.6 6258.2 6267.8 5456.7 5492.5 5527.8 5532.2 5596.8 5347.5 5368.0 5591.9 5595.6 5598.7 5428.3 5496.5 5504.2 5512.3 5524.4 5529.2 5536.4 5540.7 5541.2 5557.0 5397.0 5468.8 5496.8 5505.8 5525.9 5952.3 6020.4 6087.7 6135.8 6141.6 6555.0 6577.7 6581.3 6582.8 6597.9 6606.5 6650.7 6659.1 6661.7 6665.1 6116.7 6138.1 6172.3 6282.4 6325.5 6576.5 6665.3 6674.8 6747.2 6774.8 6479.9 6490.4 6491.8 6499.4 6519.6 6302.1 6448.2 6585.7 6596.7 6604.6 6351.9 6393.6 6421.6 6424.3 6456.2 6277.2 6292.1 6307.3 6321.1 6561.0 5184.5 5219.1 5252.3 5264.1 5280.3 4772.0 4774.9 4792.3 4815.9 4844.0 6268.8 6286.2 6291.4 6295.5 6297.1 6332.5 6390.0 6546.7 6562.2 6667.0 6258.2 6266.3 6281.9 6286.3 6287.2 5733.1 5750.5 5783.0 5799.5 5851.1 6495.4 6562.6 6635.1 6774.6 6827.9 6583.4 6610.5 6630.3 6633.6 6634.4 6723.0 6757.4 6762.0 6766.6 6782.0 6279.5 6314.1 6498.3 6551.8 6572.2 5740.3 6368.3 6410.0 6416.7 6490.3 6396.6 6413.7 6434.0 6441.0 6442.5 6379.5 6414.6 6439.0 6443.5 6449.9 6185.6 6325.8 6326.5 6335.1 6335.6 6286.4 6318.1 6348.9 6440.5 6490.8 6163.0 6170.8 6228.3 6241.8 6299.0 08:46:17 INFO - PROCESS | 3312 | 08:46:17 INFO - PROCESS | 3312 | [#1] ext.html Cycles:180 Average:55527.08 Median:33445.33 stddev:109234.22 (326.6%) stddev-sans-first:109463.38 08:46:17 INFO - PROCESS | 3312 | Values: 804.6 824.6 905.8 906.9 915.9 37371.8 41274.0 41419.8 41534.6 41669.6 43364.1 43485.8 43553.6 43638.3 43640.0 7887.7 8029.3 9622.6 9791.6 9815.5 8012.3 8070.2 8107.5 11759.8 11916.2 11972.8 12000.3 12034.2 12066.3 12073.8 11953.9 11978.6 11991.7 11991.8 12012.2 11520.1 11523.4 11540.0 11543.8 11550.1 40076.8 40139.0 40158.2 40283.6 40344.4 4053.3 4070.7 4110.4 4116.5 4129.3 28609.4 28682.6 30654.5 30901.7 31037.8 3270.4 3288.2 3308.7 3422.4 3427.0 353074.0 358684.0 358772.4 359506.0 360359.0 43814.6 44582.8 46823.8 53853.7 54198.5 55618.4 56623.7 59698.5 59721.0 59892.4 12866.8 15649.1 15695.0 15717.1 15749.9 13240.0 13281.1 13301.0 13305.9 13309.9 12487.9 12507.7 12566.0 12613.2 12663.1 5489.6 5516.6 5523.6 5530.3 5532.1 1097.5 1147.6 1173.2 1178.5 1225.0 27248.3 27836.6 27843.4 27984.2 28144.4 1281.7 1281.9 1294.4 1338.0 1339.1 12514.7 13879.8 14251.5 14253.0 14583.4 473185.0 473978.0 474206.0 474250.0 475248.6 57196.7 57281.7 57440.0 57447.7 57517.7 1450.4 1460.6 1474.2 1506.7 1508.2 26298.5 27544.2 28090.6 28233.9 28253.3 38773.8 38814.0 39036.4 39046.6 39050.6 396212.0 396246.0 396850.0 397339.0 398937.0 24962.9 25148.7 26297.1 26568.5 30041.4 32165.7 37989.8 38673.8 38738.8 39736.0 23353.9 26663.0 26871.9 29250.9 29368.1 27856.9 27872.9 28041.0 28217.9 29105.0 33640.8 33659.0 33696.5 42228.9 43146.6 33705.0 39310.4 41835.4 42300.7 43270.8 32113.8 33012.3 33017.7 33060.0 33249.8 08:46:17 INFO - PROCESS | 3312 | 08:46:17 INFO - PROCESS | 3312 | [#2] jquery.html Cycles:180 Average:43130.99 Median:12189.02 stddev:124986.40 (1025.4%) stddev-sans-first:125295.79 08:46:17 INFO - PROCESS | 3312 | Values: 379.6 422.4 428.0 431.6 459.8 18405.5 21330.4 22930.2 23143.7 23471.0 20095.7 20372.1 22751.0 24135.5 24462.6 5852.7 6758.3 7013.3 7198.5 7270.1 7097.7 7143.1 7223.2 7246.0 7262.7 6861.7 7136.0 7194.7 7211.2 7222.2 6855.3 7085.3 7139.2 7196.7 7213.5 6958.8 6980.8 6982.5 6983.9 7001.5 19652.5 28228.2 28397.4 28516.9 28756.3 2603.4 2740.7 3010.6 3016.1 3051.7 7660.5 7728.1 12785.6 15622.8 17540.6 1956.7 2080.4 2105.2 2197.7 2283.5 91874.6 100426.0 118362.0 139368.0 143260.0 22180.3 22312.7 22337.9 22482.2 22548.5 36103.0 36426.3 36876.4 36920.8 37002.0 11319.4 11534.5 11748.4 11773.6 11990.0 7645.6 9432.3 9458.8 9598.3 9658.7 10576.7 10921.6 10945.1 11017.4 11060.0 3374.3 3527.9 3817.2 4039.3 4045.7 1018.1 1020.6 1089.2 1131.2 1153.7 23235.3 23412.9 23512.4 23907.3 24190.0 912.8 1007.4 1144.5 1170.4 1179.2 11859.8 12234.9 12416.4 12478.8 12488.6 673508.0 760732.2 762835.0 771985.0 791270.0 130076.0 131616.3 137405.0 175293.0 177957.0 1249.5 1252.0 1302.7 1307.8 1318.3 20425.8 20999.7 21209.0 21277.6 21474.5 67096.0 67187.0 67901.6 68377.7 69119.7 99995.0 100265.0 100891.0 101539.0 103300.5 11866.4 12003.8 12221.3 12332.8 12453.8 13679.8 13687.2 13808.9 14052.8 14279.2 11592.0 11702.2 11935.8 11939.0 12068.0 10910.9 10952.8 11043.8 11373.8 11409.4 9539.6 11681.2 11849.2 12055.7 12113.8 11863.7 11922.9 12172.2 12211.2 12272.9 9351.4 9514.0 11797.9 11937.6 12042.6 08:46:17 INFO - PROCESS | 3312 | 08:46:17 INFO - PROCESS | 3312 | [#3] mootools.html Cycles:180 Average:6884.84 Median:2514.55 stddev:4312.46 (171.5%) stddev-sans-first:4306.29 08:46:17 INFO - PROCESS | 3312 | Values: 1601.6 1615.2 1635.8 1642.5 1648.9 10851.5 11508.6 11520.1 11534.9 11563.2 11206.6 11376.7 11685.5 11730.8 11743.2 2457.4 2523.5 2525.6 2526.7 2533.3 2444.0 2458.2 2497.0 2501.3 2505.6 2451.1 2463.1 2476.9 2488.1 2491.9 2400.3 2444.5 2453.3 2467.9 2468.5 2417.6 2441.3 2451.1 2453.9 2456.4 11157.3 11391.0 11394.2 11397.1 11423.3 5909.9 6094.5 6100.5 6107.3 6109.5 3534.2 3616.5 3621.8 3680.6 3691.7 1197.6 1222.7 1222.7 1265.3 1278.9 11028.6 13839.7 14195.8 15703.0 16119.0 4878.2 5021.1 5056.5 5084.7 5087.7 12209.9 13258.5 13273.4 13312.5 13318.9 4820.7 5120.9 6096.6 6135.1 6139.8 5147.3 5310.3 5390.1 5399.0 5400.5 4161.5 4170.8 4242.2 4269.7 4299.4 1136.9 1147.3 1153.1 1167.2 1168.2 938.3 969.3 975.7 983.4 996.6 6699.6 6737.3 6738.8 6818.2 6893.8 864.4 967.8 972.6 990.7 1037.3 3007.6 3012.1 3228.9 3279.2 3370.1 13019.1 13792.5 14127.6 14129.2 14138.7 13752.5 13970.7 14071.5 14177.6 14201.6 8756.8 10364.4 10558.0 10624.0 10690.3 6527.4 6564.9 6633.5 6675.2 6723.4 12363.5 12381.3 12413.6 12528.1 12602.0 12698.2 12804.0 12816.6 12984.5 12994.1 9395.3 9410.5 9431.7 9562.2 9566.2 10407.2 10419.8 10542.3 10574.5 10611.5 8958.3 8989.4 9055.2 9113.0 9121.9 8677.0 8757.7 8815.3 8872.7 8910.4 7869.0 8026.4 8056.7 8229.0 8264.8 5941.2 5952.6 6002.5 6122.1 6184.2 5942.7 5955.6 6144.3 6224.5 6252.8 08:46:17 INFO - PROCESS | 3312 | 08:46:17 INFO - PROCESS | 3312 | [#4] prototype.html Cycles:180 Average:4585.85 Median:4977.90 stddev:1278.94 (25.7%) stddev-sans-first:1242.03 08:46:17 INFO - PROCESS | 3312 | Values: 331.7 377.2 392.0 394.0 397.9 4423.4 4708.0 5253.8 5254.8 5262.6 4358.8 4651.7 4957.1 5149.8 5195.5 4322.7 4328.5 4338.4 4344.9 4356.7 3636.8 3825.8 4331.4 4367.9 4375.6 3404.6 3577.1 3766.0 3964.9 4334.6 4208.9 4242.9 4250.7 4252.4 4279.4 3223.9 3935.4 3950.0 3965.3 3966.5 4740.7 4993.7 5078.9 5141.1 5245.8 4630.7 4965.7 4968.0 4982.0 5018.4 4492.4 5264.4 5514.3 5551.3 5556.0 4025.2 4135.1 4410.8 4450.6 4458.5 4594.8 5196.9 5511.9 5568.5 5753.9 4361.2 4391.3 4403.4 4535.7 4589.5 4649.9 4667.6 4668.5 4706.6 4721.6 4343.5 4618.5 4938.8 4978.0 4983.1 4969.8 5219.3 5269.5 5468.5 5486.4 1440.7 1476.2 1564.5 1567.3 1577.7 926.7 1109.8 1168.7 1175.0 1179.9 4646.0 4646.7 4670.0 4961.1 5157.6 5639.7 5655.8 5664.9 5673.6 5695.9 4773.7 4977.8 4982.4 5111.1 5118.7 2582.9 2593.6 2784.9 2926.7 2956.5 5351.1 5617.3 5851.4 5893.7 5894.6 5167.2 5312.0 5363.5 5540.6 5631.2 4919.9 5070.5 5180.9 5852.4 5900.2 5310.5 5323.8 5704.8 5710.7 5726.7 5010.8 5635.0 5657.3 5731.9 5738.4 5273.5 5593.2 5711.1 5745.6 5926.3 3999.5 4535.2 4541.1 4563.7 4587.4 5191.6 5321.9 5553.3 5697.4 5753.4 4883.8 5258.4 5480.3 5513.9 5537.1 5302.6 5486.5 5515.4 5524.1 5597.4 4643.3 5052.8 5085.5 5444.0 5471.8 4717.9 4870.7 5413.6 5463.6 5538.0 4839.1 5199.2 5404.6 5411.3 5420.8 08:46:17 INFO - PROCESS | 3312 | 08:46:17 INFO - PROCESS | 3312 | [#5] yui.html Cycles:180 Average:21296.53 Median:18206.45 stddev:31203.17 (171.4%) stddev-sans-first:31252.66 08:46:17 INFO - PROCESS | 3312 | Values: 777.0 792.7 830.8 888.4 893.8 16024.9 17712.6 17731.9 17752.2 17789.1 16128.5 16180.8 16367.6 16375.6 16390.5 972.8 975.6 977.6 978.3 991.5 894.3 995.6 1019.4 1036.8 1038.3 1065.5 1065.6 1067.0 1068.2 1071.7 1062.5 1063.7 1064.1 1066.0 1066.1 792.2 792.7 793.1 793.1 794.1 17547.4 17928.2 18000.3 18146.9 18266.0 14676.0 14744.4 14910.8 14952.9 15160.4 11936.6 11940.0 12296.3 12472.9 12892.2 3750.7 3801.0 3984.6 4114.7 4121.0 109521.0 115826.0 117574.4 118077.4 121305.0 11062.5 11469.9 11503.3 11638.2 11640.9 23600.2 23989.2 24008.5 24017.8 24031.4 8185.3 8225.9 8226.6 8278.4 8337.2 4653.5 4668.5 4697.4 4709.5 4781.6 3368.7 3447.5 3470.6 3474.5 3475.7 624.2 646.7 647.7 660.5 668.9 671.5 703.4 708.6 723.0 771.5 10437.7 10897.9 10949.3 11048.7 11221.4 731.1 743.9 760.2 768.2 774.0 4608.0 4929.3 5147.0 5255.4 5266.2 106753.0 107942.9 109279.5 112595.4 113226.9 72793.3 92535.5 93882.1 95952.0 96733.5 80636.6 80687.0 82599.6 83450.6 84012.0 10128.4 10243.7 10296.6 10340.3 10428.2 47271.0 52872.5 52963.0 54447.5 55411.0 52729.0 68146.0 69311.3 70244.0 70878.9 11538.7 11569.1 11606.2 11861.3 12069.2 11835.3 12514.6 13126.4 13522.7 13556.1 12139.0 12149.4 12509.6 12832.3 12897.2 11872.0 11878.2 12319.9 12663.4 12674.0 12093.2 12128.5 12136.2 12201.2 12250.3 6994.9 8108.6 8538.1 8723.2 8850.5 9672.9 10203.5 10356.5 10369.3 10406.2 08:46:17 INFO - PROCESS | 3312 | -------- Summary: end -------- 08:46:17 INFO - PROCESS | 3312 | 08:46:17 INFO - TEST-INFO | 3312: exit 0 08:46:17 INFO - TEST-OK | dromaeo_css | took 1119337ms 08:46:17 INFO - TEST-START | kraken 08:46:17 INFO - operating with platform_type : mac_ 08:46:17 INFO - Initialising browser for kraken test... 08:46:17 INFO - TEST-INFO | started process 3315 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpWDGSsD/profile http://localhost:64624/getInfo.html) 08:46:20 INFO - PROCESS | 3315 | __metrics Screen width/height:1600/1200 08:46:20 INFO - PROCESS | 3315 | colorDepth:24 08:46:20 INFO - PROCESS | 3315 | Browser inner width/height: 1024/689 08:46:20 INFO - PROCESS | 3315 | __metrics 08:46:20 INFO - PROCESS | 3315 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:46:20 INFO - PROCESS | 3315 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:46:21 INFO - TEST-INFO | 3315: exit 0 08:46:21 INFO - Browser initialized. 08:46:21 INFO - Running cycle 1/1 for kraken test... 08:46:21 INFO - TEST-INFO | started process 3317 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpWDGSsD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:33 INFO - PROCESS | 3317 | RSS: Main: 169533440 08:46:33 INFO - PROCESS | 3317 | 08:46:35 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:64624/tests/kraken/driver.html?testName=audio-beat-detection) 08:46:36 INFO - PROCESS | 3317 | RSS: Main: 220667904 08:46:36 INFO - PROCESS | 3317 | 08:46:39 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:64624/tests/kraken/driver.html?testName=audio-dft) 08:46:40 INFO - PROCESS | 3317 | RSS: Main: 231219200 08:46:40 INFO - PROCESS | 3317 | 08:46:43 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:64624/tests/kraken/driver.html?testName=audio-fft) 08:46:43 INFO - PROCESS | 3317 | RSS: Main: 326225920 08:46:43 INFO - PROCESS | 3317 | 08:46:45 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:64624/tests/kraken/driver.html?testName=audio-oscillator) 08:46:46 INFO - PROCESS | 3317 | RSS: Main: 229863424 08:46:46 INFO - PROCESS | 3317 | 08:46:48 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:64624/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:46:49 INFO - PROCESS | 3317 | RSS: Main: 232271872 08:46:49 INFO - PROCESS | 3317 | 08:46:51 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:64624/tests/kraken/driver.html?testName=imaging-darkroom) 08:46:52 INFO - PROCESS | 3317 | RSS: Main: 274698240 08:46:52 INFO - PROCESS | 3317 | 08:46:55 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:64624/tests/kraken/driver.html?testName=imaging-desaturate) 08:46:56 INFO - PROCESS | 3317 | RSS: Main: 273772544 08:46:56 INFO - PROCESS | 3317 | 08:46:59 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:64624/tests/kraken/driver.html?testName=json-parse-financial) 08:46:59 INFO - PROCESS | 3317 | RSS: Main: 272113664 08:46:59 INFO - PROCESS | 3317 | 08:47:01 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:64624/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:47:02 INFO - PROCESS | 3317 | RSS: Main: 249860096 08:47:02 INFO - PROCESS | 3317 | 08:47:04 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:64624/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:47:04 INFO - PROCESS | 3317 | RSS: Main: 251502592 08:47:04 INFO - PROCESS | 3317 | 08:47:06 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:64624/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:47:07 INFO - PROCESS | 3317 | RSS: Main: 258027520 08:47:07 INFO - PROCESS | 3317 | 08:47:10 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:64624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:47:11 INFO - PROCESS | 3317 | RSS: Main: 262168576 08:47:11 INFO - PROCESS | 3317 | 08:47:13 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:64624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:47:14 INFO - PROCESS | 3317 | RSS: Main: 263258112 08:47:14 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | Cycle 1(1): loaded http://localhost:64624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:64624/tests/kraken/driver.html?testName=ai-astar) 08:47:16 INFO - PROCESS | 3317 | RSS: Main: 308060160 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | __start_tp_report 08:47:16 INFO - PROCESS | 3317 | _x_x_mozilla_page_load 08:47:16 INFO - PROCESS | 3317 | _x_x_mozilla_page_load_details 08:47:16 INFO - PROCESS | 3317 | |i|pagename|runs| 08:47:16 INFO - PROCESS | 3317 | |0;ai-astar;116;115;115;114;114;115;123;133;114;115 08:47:16 INFO - PROCESS | 3317 | |1;audio-beat-detection;170;125;109;149;124;110;108;106;124;93 08:47:16 INFO - PROCESS | 3317 | |2;audio-dft;187;186;184;184;185;185;186;186;185;187 08:47:16 INFO - PROCESS | 3317 | |3;audio-fft;85;61;69;96;61;59;60;62;66;59 08:47:16 INFO - PROCESS | 3317 | |4;audio-oscillator;87;68;86;69;70;67;81;67;68;82 08:47:16 INFO - PROCESS | 3317 | |5;imaging-gaussian-blur;73;75;110;134;87;86;87;87;87;86 08:47:16 INFO - PROCESS | 3317 | |6;imaging-darkroom;95;93;95;94;93;94;94;94;94;94 08:47:16 INFO - PROCESS | 3317 | |7;imaging-desaturate;87;85;85;86;94;139;138;73;129;138 08:47:16 INFO - PROCESS | 3317 | |8;json-parse-financial;61;59;59;61;65;62;65;62;65;63 08:47:16 INFO - PROCESS | 3317 | |9;json-stringify-tinderbox;56;65;64;66;61;58;59;58;59;60 08:47:16 INFO - PROCESS | 3317 | |10;stanford-crypto-aes;82;84;85;84;82;84;88;85;107;95 08:47:16 INFO - PROCESS | 3317 | |11;stanford-crypto-ccm;136;132;134;133;127;141;148;142;150;134 08:47:16 INFO - PROCESS | 3317 | |12;stanford-crypto-pbkdf2;164;223;206;163;159;163;161;160;161;163 08:47:16 INFO - PROCESS | 3317 | |13;stanford-crypto-sha256-iterative;65;64;65;63;65;64;64;64;63;63 08:47:16 INFO - PROCESS | 3317 | __end_tp_report 08:47:16 INFO - PROCESS | 3317 | __start_cc_report 08:47:16 INFO - PROCESS | 3317 | _x_x_mozilla_cycle_collect,2069 08:47:16 INFO - PROCESS | 3317 | __end_cc_report 08:47:16 INFO - PROCESS | 3317 | __startTimestamp1493221636551__endTimestamp 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | ------- Summary: start ------- 08:47:16 INFO - PROCESS | 3317 | Number of tests: 14 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#0] ai-astar Cycles:10 Average:117.40 Median:115.00 stddev:6.10 (5.3%) stddev-sans-first:6.44 08:47:16 INFO - PROCESS | 3317 | Values: 116.0 115.0 115.0 114.0 114.0 115.0 123.0 133.0 114.0 115.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#1] audio-beat-detection Cycles:10 Average:121.80 Median:124.50 stddev:22.74 (18.3%) stddev-sans-first:16.10 08:47:16 INFO - PROCESS | 3317 | Values: 170.0 125.0 109.0 149.0 124.0 110.0 108.0 106.0 124.0 93.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#2] audio-dft Cycles:10 Average:185.50 Median:186.00 stddev:1.08 (0.6%) stddev-sans-first:1.00 08:47:16 INFO - PROCESS | 3317 | Values: 187.0 186.0 184.0 184.0 185.0 185.0 186.0 186.0 185.0 187.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#3] audio-fft Cycles:10 Average:67.80 Median:64.00 stddev:12.64 (19.7%) stddev-sans-first:11.77 08:47:16 INFO - PROCESS | 3317 | Values: 85.0 61.0 69.0 96.0 61.0 59.0 60.0 62.0 66.0 59.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#4] audio-oscillator Cycles:10 Average:74.50 Median:75.50 stddev:8.40 (11.1%) stddev-sans-first:7.59 08:47:16 INFO - PROCESS | 3317 | Values: 87.0 68.0 86.0 69.0 70.0 67.0 81.0 67.0 68.0 82.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:86.50 stddev:17.96 (20.8%) stddev-sans-first:17.80 08:47:16 INFO - PROCESS | 3317 | Values: 73.0 75.0 110.0 134.0 87.0 86.0 87.0 87.0 87.0 86.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 08:47:16 INFO - PROCESS | 3317 | Values: 95.0 93.0 95.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#7] imaging-desaturate Cycles:10 Average:105.40 Median:85.00 stddev:26.95 (31.7%) stddev-sans-first:27.75 08:47:16 INFO - PROCESS | 3317 | Values: 87.0 85.0 85.0 86.0 94.0 139.0 138.0 73.0 129.0 138.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.50 stddev:2.30 (3.7%) stddev-sans-first:2.40 08:47:16 INFO - PROCESS | 3317 | Values: 61.0 59.0 59.0 61.0 65.0 62.0 65.0 62.0 65.0 63.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.50 stddev:3.34 (5.5%) stddev-sans-first:3.10 08:47:16 INFO - PROCESS | 3317 | Values: 56.0 65.0 64.0 66.0 61.0 58.0 59.0 58.0 59.0 60.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:84.50 stddev:7.79 (9.2%) stddev-sans-first:8.00 08:47:16 INFO - PROCESS | 3317 | Values: 82.0 84.0 85.0 84.0 82.0 84.0 88.0 85.0 107.0 95.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:138.50 stddev:7.35 (5.3%) stddev-sans-first:7.77 08:47:16 INFO - PROCESS | 3317 | Values: 136.0 132.0 134.0 133.0 127.0 141.0 148.0 142.0 150.0 134.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:163.00 stddev:22.65 (13.9%) stddev-sans-first:23.83 08:47:16 INFO - PROCESS | 3317 | Values: 164.0 223.0 206.0 163.0 159.0 163.0 161.0 160.0 161.0 163.0 08:47:16 INFO - PROCESS | 3317 | 08:47:16 INFO - PROCESS | 3317 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 08:47:16 INFO - PROCESS | 3317 | Values: 65.0 64.0 65.0 63.0 65.0 64.0 64.0 64.0 63.0 63.0 08:47:16 INFO - PROCESS | 3317 | -------- Summary: end -------- 08:47:16 INFO - PROCESS | 3317 | 08:47:17 INFO - TEST-INFO | 3317: exit 0 08:47:17 INFO - TEST-OK | kraken | took 59540ms 08:47:17 INFO - SUITE-END | took 1178s 08:47:17 INFO - Completed test suite (00:19:39) 08:47:17 INFO - javascript benchmark 08:47:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7900.165950928914, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3227.096413004359, 3494.7903125812454, 3496.1609213788697, 3543.1319326764947, 3556.164301389173, 6142.109394137853, 6167.876642467148, 6197.039458883869, 6198.597091189075, 6209.223847019122, 6141.6622085785375, 6243.71903264353, 6251.59364641298, 6258.2490101187805, 6267.780627678032, 5456.672599644025, 5492.533134683536, 5527.778888844441, 5532.170174473821, 5596.776128954857, 5347.465253474641, 5368.033753924292, 5591.916121258185, 5595.608307418483, 5598.664080155183, 5428.267183930158, 5496.4503549645115, 5504.2018907258425, 5512.255845460872, 5524.4199359067325, 5529.225908372831, 5536.446355364472, 5540.667559946376, 5541.168824676291, 5556.972215138939, 5397.0, 5468.808591699271, 5496.80761173361, 5505.807296744635, 5525.889482210374, 5952.285725712942, 6020.367861374581, 6087.695615219265, 6135.846603834895, 6141.600795948294, 6555.04951781989, 6577.736890524373, 6581.2760596334365, 6582.769603063918, 6597.868042639168, 6606.504512161559, 6650.700718467632, 6659.067730517731, 6661.733530658767, 6665.066890635315, 6116.724747386378, 6138.094643526033, 6172.321044685081, 6282.403171698681, 6325.5255855811, 6576.506761992774, 6665.266820649725, 6674.766383176662, 6747.190337159573, 6774.796756097325, 6479.902801457982, 6490.350964903472, 6491.772787952399, 6499.350064993463, 6519.576227545194, 6302.1177035215105, 6448.161738973997, 6585.703643336062, 6596.670166491656, 6604.603723776589, 6351.904721429182, 6393.552451328455, 6421.614703117828, 6424.293327733945, 6456.160699109179, 6277.18396608438, 6292.05619157121, 6307.306196318401, 6321.146645202839, 6561.0, 5184.507471790174, 5219.086659834514, 5252.264682944391, 5264.05247055526, 5280.260763493114, 4771.976140119277, 4774.928376074362, 4792.329073929653, 4815.903681926342, 4843.975780121077, 6268.780592679325, 6286.214223222098, 6291.433770960635, 6295.464885484694, 6297.086922396227, 6332.4934005279465, 6389.9680501597195, 6546.738130474823, 6562.212534495891, 6666.966665166643, 6258.249010118815, 6266.342034086447, 6281.905771413432, 6286.277078135981, 6287.151234583364, 5733.140028995684, 5750.453706897838, 5783.0, 5799.536037117021, 5851.093080572518, 6495.415412612888, 6562.573432727048, 6635.137432133792, 6774.627395493098, 6827.897581536182, 6583.374579414948, 6610.471162306908, 6630.30381809903, 6633.568818026813, 6634.436072933661, 6722.9663851680425, 6757.425618822455, 6761.966190169018, 6766.560173588701, 6782.016607591971, 6279.497640188682, 6314.052892066226, 6498.285188629153, 6551.770688026087, 6572.244191917991, 5740.311162660508, 6368.267649220399, 6409.9679501602195, 6416.743330266737, 6490.3185165558825, 6396.584222025554, 6413.7113829876835, 6433.970564709624, 6440.967795160994, 6442.484601231984, 6379.457746091634, 6414.550981431442, 6438.967805160944, 6443.548951573345, 6449.9355006451215, 6185.597936134137, 6325.810225693236, 6326.525510586633, 6335.081413195153, 6335.588186767845, 6286.371362863677, 6318.147050148171, 6348.93651063502, 6440.516961228021, 6490.8052758417325, 6163.044728067157, 6170.81487555374, 6228.314885362516, 6241.843953901189, 6298.968505157445], "value": 6040.202565052854, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.6017221475369, 824.5918270456124, 905.8278927003864, 906.895706993696, 915.890093188817, 37371.813140934326, 41273.968150796245, 41419.75740727776, 41534.58465415353, 41669.58330416695, 43364.13271734571, 43485.78257108718, 43553.564464355426, 43638.34542481865, 43640.0, 7887.723929662463, 8029.317508011826, 9622.566984485697, 9791.608335666564, 9815.50922453878, 8012.318952889012, 8070.152633973436, 8107.513549187068, 11759.7648047039, 11916.225445346025, 11972.760544789098, 12000.33998130107, 12034.217775844541, 12066.336351500664, 12073.818892716572, 11953.940230298793, 11978.580749673763, 11991.700207494796, 11991.820122698211, 12012.219205751599, 11520.078393728481, 11523.366214858179, 11540.019098376648, 11543.826842597367, 11550.133739969537, 40076.799616001736, 40139.0, 40158.196836063405, 40283.59716402828, 40344.39483407751, 4053.250148722496, 4070.735402198877, 4110.403991421257, 4116.5060192776755, 4129.318662420697, 28609.427811443653, 28682.554204098396, 30654.54018189729, 30901.690983090106, 31037.844810776027, 3270.4440245158144, 3288.1615188126875, 3308.67652938824, 3422.435298175798, 3427.0404286799735, 353074.0, 358684.0, 358772.4122758765, 359506.0, 360359.0, 43814.56185438169, 44582.77708611501, 46823.82940426517, 53853.73073134609, 54198.45801542013, 55618.443815561324, 56623.71688141533, 59698.50753731192, 59721.0, 59892.401075989554, 12866.806997895039, 15649.139297338528, 15694.979826311253, 15717.113946326514, 15749.921250393674, 13240.0, 13281.070325077151, 13301.0, 13305.93347033278, 13309.93345033288, 12487.93756031214, 12507.687307817378, 12566.0, 12613.243205407522, 12663.050271229695, 5489.64317319373, 5516.586256030814, 5523.640963337451, 5530.253415788817, 5532.1232958861165, 1097.5006372100675, 1147.5926046253626, 1173.20808454293, 1178.4755783676183, 1225.0, 27248.31879202996, 27836.582451263246, 27843.443131137265, 27984.160475185778, 28144.43711125766, 1281.6731733407921, 1281.8910392616733, 1294.3851670456459, 1337.9732405351838, 1339.0760375340983, 12514.749705005848, 13879.791803122962, 14251.50119745804, 14253.038168546345, 14583.416663333348, 473185.0, 473978.0, 474206.0, 474250.0, 475248.623756879, 57196.71401642965, 57281.71359143178, 57440.0, 57447.71276143593, 57517.712411438515, 1450.3690894460733, 1460.5983354577577, 1474.1597289544857, 1506.6835964447368, 1508.2383396384755, 26298.474030519665, 27544.17367478979, 28090.57864131999, 28233.858830705714, 28253.29366765765, 38773.80613096916, 38814.0, 39036.41445378265, 39046.60953390544, 39050.609493904696, 396212.0, 396246.0, 396850.0, 397339.0, 398937.0, 24962.87518562468, 25148.74851251464, 26297.07960221383, 26568.468630626892, 30041.399172016, 32165.678343216267, 37989.81005094957, 38673.80663096667, 38738.80630596829, 39736.0, 23353.88323058374, 26663.0, 26871.865640671673, 29250.853745731136, 29368.118956431343, 27856.88572457079, 27872.860635697503, 28041.01856435015, 28217.858910705316, 29105.0, 33640.831795840866, 33659.0, 33696.49455258222, 42228.94427639333, 43146.568534314254, 33705.0, 39310.41034384429, 41835.37246941359, 42300.73097807071, 43270.78364608157, 32113.8394308027, 33012.339753205284, 33017.67929282802, 33060.0, 33249.833750831094], "value": 19319.583129105897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.56350197273133, 422.37488516994864, 427.9786010699464, 431.624486696574, 459.79539105098223, 18405.53986150347, 21330.36008919731, 22930.197443089473, 23143.652845207293, 23471.0, 20095.698564521543, 20372.083256253467, 22751.0, 24135.51728965424, 24462.633060504064, 5852.678102704371, 6758.290379510155, 7013.3337332953415, 7198.4601154913325, 7270.091238595176, 7097.716091356339, 7143.071400717899, 7223.241559636215, 7245.963770181168, 7262.745803896864, 6861.656917154122, 7136.000959865623, 7194.676239569206, 7211.206767255598, 7222.241664625218, 6855.280195579492, 7085.326893945067, 7139.214686384494, 7196.676149573282, 7213.531120477179, 6958.756443524503, 6980.7905762827195, 6982.546134501241, 6983.89524157138, 7001.544899581511, 19652.50868728279, 28228.15315540537, 28397.432051359065, 28516.857415712995, 28756.281092972633, 2603.3621762668267, 2740.657417822772, 3010.6086208792935, 3016.08009557085, 3051.7406020488284, 7660.5403675779635, 7728.072631284282, 12785.552505662257, 15622.843771562253, 17540.649187016188, 1956.7064940259074, 2080.4070839810583, 2105.221068204774, 2197.7142971413773, 2283.5204607032542, 91874.6031821802, 100426.0, 118362.0, 139368.0, 143260.0, 22180.334589962327, 22312.665310020362, 22337.88310584497, 22482.21312254096, 22548.549029019658, 36103.0, 36426.27147457089, 36876.446853297224, 36920.81539592285, 37002.0, 11319.37743424103, 11534.480948357177, 11748.412579370997, 11773.646790596296, 11990.0, 7645.5794931279315, 9432.339736218537, 9458.810823783486, 9598.32811703188, 9658.661946831828, 10576.682699519026, 10921.563137474572, 10945.124390048777, 11017.394043327695, 11059.953908526948, 3374.3420033093803, 3527.8588856445967, 3817.1983883384246, 4039.2527382434346, 4045.696572757055, 1018.144105783285, 1020.5815615597569, 1089.1559041742712, 1131.179894576442, 1153.7000379901285, 23235.3029409118, 23412.946417411258, 23512.412189695053, 23907.282781516584, 24190.0, 912.771807048238, 1007.4207330784828, 1144.547903578082, 1170.4206417823232, 1179.2452830188686, 11859.762804743857, 12234.858899692517, 12416.379181040911, 12478.81281780774, 12488.562900298446, 673508.0, 760732.1963390259, 762835.0, 771985.0, 791270.0, 130076.0, 131616.3419182898, 137405.0, 175293.0, 177957.0, 1249.4502418935822, 1251.9687007824696, 1302.7003789128364, 1307.7776777947772, 1318.2815365625756, 20425.795742042388, 20999.685004724637, 21208.993403042972, 21277.574448510633, 21474.463138421663, 67096.0, 67187.0, 67901.64196715939, 68377.65811170913, 69119.65440172968, 99995.0, 100265.0, 100891.0, 101539.0, 103300.48349758203, 11866.406679666155, 12003.75992480163, 12221.28901953745, 12332.753344933231, 12453.754624537474, 13679.79480307816, 13687.248469596716, 13808.93095534556, 14052.78920816209, 14279.21464319431, 11592.0, 11702.180847340604, 11935.76128477443, 11939.04487641004, 12068.034557235225, 10910.945445272722, 10952.78094438091, 11043.83434248503, 11373.829392558953, 11409.429528523375, 9539.618415263312, 11681.240719353214, 11849.229800062969, 12055.698607534881, 12113.81829272544, 11863.71223251678, 11922.940385298365, 12172.208806427909, 12211.206271592673, 12272.938635306766, 9351.438913665203, 9514.0, 11797.941010295237, 11937.582184623496, 12042.578509752468], "value": 12019.486967738565, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1601.574598607239, 1615.2004757644968, 1635.8037035555735, 1642.4579888636745, 1648.8928219665722, 10851.51168197431, 11508.597199098032, 11520.135989800778, 11534.884651153487, 11563.190576659626, 11206.607768728096, 11376.658700239006, 11685.532578696842, 11730.7653846923, 11743.177977541576, 2457.3733697907055, 2523.49530093981, 2525.6337831014494, 2526.68416447944, 2533.3160046787357, 2444.0346063304983, 2458.1887976967646, 2497.0386401235564, 2501.2996361018945, 2505.5991041433376, 2451.1053465485147, 2463.1379017343966, 2476.913308034219, 2488.1167185649106, 2491.8504889706587, 2400.279916025203, 2444.4744379958215, 2453.337598848301, 2467.938301542458, 2468.4816188600325, 2417.601095819188, 2441.2554170977846, 2451.142100264911, 2453.852768833876, 2456.361346050022, 11157.27477713946, 11390.974812266935, 11394.202405831595, 11397.145214108976, 11423.314601123959, 5909.940900591025, 6094.451499365034, 6100.450959413674, 6107.29766076898, 6109.4501494865235, 3534.1871369584883, 3616.5117709109195, 3621.7645853019735, 3680.6319368063246, 3691.70466362693, 1197.598804400527, 1222.6821026533075, 1222.712662524306, 1265.329375431023, 1278.9424475898606, 11028.558857645685, 13839.723205535933, 14195.787063194164, 15703.0, 16119.032858028439, 4878.219484882402, 5021.14640511114, 5056.494350564988, 5084.694918304914, 5087.720175390389, 12209.938950305192, 13258.53595124166, 13273.402696878664, 13312.534061307808, 13318.933405332911, 4820.662553621213, 5120.92318615221, 6096.573239873255, 6135.141080248769, 6139.754409823557, 5147.279380886679, 5310.2831117798605, 5390.110631745718, 5399.0, 5400.459954004568, 4161.542230354658, 4170.778887529093, 4242.17277630859, 4269.743815371087, 4299.398084268205, 1136.8740455348552, 1147.3345459633392, 1153.1005815463952, 1167.1888037813808, 1168.2406435816788, 938.2775263047415, 969.2633598465217, 975.7170420578095, 983.4246965525105, 996.5549952568804, 6699.6315202663345, 6737.29258427858, 6738.831529211711, 6818.249992500821, 6893.7931862044215, 864.4208380385157, 967.8257913575483, 972.5769290358717, 990.6928852055742, 1037.2894567221326, 3007.624046994126, 3012.051203870774, 3228.935421291561, 3279.1942835532504, 3370.0563842124243, 13019.088663793444, 13792.517261895786, 14127.576172714835, 14129.152250864981, 14138.71722565543, 13752.518661846787, 13970.720585588231, 14071.507497237548, 14177.645558861112, 14201.644958876112, 8756.781080472912, 10364.429956352322, 10558.04977552024, 10623.990720881658, 10690.251682382313, 6527.412532872065, 6564.868702625825, 6633.474300910914, 6675.23234828001, 6723.428508576826, 12363.505459781509, 12381.319027453215, 12413.627591172279, 12528.060395470195, 12602.0, 12698.238105713686, 12804.0, 12816.551420700604, 12984.545540906402, 12994.090413670952, 9395.32330114053, 9410.482423466776, 9431.717048488556, 9562.18721408688, 9566.234701223746, 10407.219458540489, 10419.791604168026, 10542.26204165701, 10574.471276436301, 10611.469426528489, 8958.328125390492, 8989.370744047854, 9055.18503334703, 9112.95443522778, 9121.908780912372, 8677.002144753435, 8757.693480728143, 8815.338849586178, 8872.73381798547, 8910.376273660782, 7868.960655196687, 8026.43814932949, 8056.7180148694515, 8228.958855205925, 8264.752057438287, 5941.197938278277, 5952.58331916779, 6002.489788368038, 6122.142899994094, 6184.196054512884, 5942.73257703413, 5955.612885162451, 6144.262688477412, 6224.533160012927, 6252.781152659635], "value": 5251.005148967941, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.71141107236707, 377.155172413793, 391.9960800391995, 393.9684825213983, 397.93434083376246, 4423.424954755881, 4707.963363630456, 5253.8441542860555, 5254.7635356408955, 5262.631615786897, 4358.825646974117, 4651.697524693083, 4957.141072097963, 5149.794008239666, 5195.506426889449, 4322.697411181219, 4328.523862375152, 4338.370936214247, 4344.9348259776125, 4356.65146788257, 3636.818159092048, 3825.8469661213517, 4331.436913201295, 4367.934480982772, 4375.6499480041675, 3404.557407537029, 3577.069961809935, 3765.9623403765886, 3964.949288438566, 4334.566543345656, 4208.852690155861, 4242.902681042825, 4250.681198910063, 4252.425922500484, 4279.379489973952, 3223.871045158191, 3935.429362742415, 3949.980250098731, 3965.266425711253, 3966.504186976628, 4740.668153229275, 4993.725345106018, 5078.898422031576, 5141.100307446182, 5245.770547517328, 4630.652701047435, 4965.726885021322, 4967.975160124176, 4982.0, 5018.397792264952, 4492.3710680504755, 5264.368275806928, 5514.283143191359, 5551.250581171531, 5556.027440380107, 4025.19496100781, 4135.069609337905, 4410.7794610269675, 4450.554944505556, 4458.5318541553315, 4594.793234304498, 5196.882670225919, 5511.889762204773, 5568.52667523257, 5753.913691294634, 4361.236783562864, 4391.341298805205, 4403.361512580658, 4535.707323412811, 4589.5181005994555, 4649.885400698071, 4667.579917807414, 4668.533146685372, 4706.647001474903, 4721.5986641135205, 4343.522212556616, 4618.49196588375, 4938.827141050046, 4977.97951419958, 4983.127952608279, 4969.776360063805, 5219.2953951216095, 5269.499397557226, 5468.48049435303, 5486.396496385474, 1440.6542429816768, 1476.247113971882, 1564.5228205397236, 1567.2633862084801, 1577.7238983177897, 926.6756635177634, 1109.7891400633853, 1168.6735555144971, 1174.9836391521274, 1179.8820117988132, 4646.0, 4646.6747327686735, 4669.987857831679, 4961.057399094233, 5157.613179011589, 5639.746211420496, 5655.802046928337, 5664.912622620682, 5673.6028478006965, 5695.914561281584, 4773.689710168828, 4977.8302099006705, 4982.377202849644, 5111.131107711698, 5118.667286626357, 2582.9354266143123, 2593.5590949538623, 2784.9025284115364, 2926.692697266756, 2956.51217549102, 5351.127105513039, 5617.32592088952, 5851.385604511465, 5893.675847828411, 5894.557908156906, 5167.209706758384, 5312.017276803804, 5363.517283444508, 5540.612157148961, 5631.211630371751, 4919.926201106986, 5070.526689217898, 5180.948190518122, 5852.4147585241135, 5900.232969713824, 5310.495502927216, 5323.790626889798, 5704.771809127588, 5710.716338105689, 5726.68286294163, 5010.799568017239, 5635.0, 5657.264555607745, 5731.914021289601, 5738.4421658571955, 5273.499017593323, 5593.188987596857, 5711.143328500758, 5745.569082318759, 5926.259217597801, 3999.460072890123, 4535.206338890747, 4541.093700032048, 4563.7489938052395, 4587.375972981441, 5191.584673226208, 5321.920171197357, 5553.333599968029, 5697.376247769366, 5753.3958934311295, 4883.8290659826735, 5258.370814592704, 5480.314960629921, 5513.889722205614, 5537.141743029837, 5302.628815982845, 5486.533644640091, 5515.365732940602, 5524.14375771756, 5597.44025597437, 4643.303504474356, 5052.823151189691, 5085.516875896784, 5443.998660984253, 5471.8084867029465, 4717.9056418872115, 4870.683405578768, 5413.56691464674, 5463.562914966873, 5537.972310138423, 4839.112496378612, 5199.232261031268, 5404.621676482766, 5411.269478620493, 5420.834520578094], "value": 4209.32745908278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.0170734021464, 792.698774465703, 830.8089139497919, 888.4447220487195, 893.7988952485689, 16024.919875400621, 17712.64574708505, 17731.911340443312, 17752.201150948207, 17789.11054447276, 16128.516144515654, 16180.75728864068, 16367.59081022975, 16375.59061023475, 16390.508284751446, 972.7568107973007, 975.5805003848342, 977.6285011695563, 978.2760757039775, 991.5092029445399, 894.2979760887705, 995.6011803416212, 1019.3578045831116, 1036.7874585709949, 1038.2939601071268, 1065.4938904020605, 1065.6003998500562, 1067.0, 1068.1935138970066, 1071.6838532632892, 1062.4581463453694, 1063.7021633942431, 1064.1433645915035, 1065.9979619157966, 1066.0671912076932, 792.1919641965163, 792.7304716396395, 793.0919097633235, 793.1077537770009, 794.06697130871, 17547.385841495485, 17928.193231304624, 18000.279988800565, 18146.90926545372, 18266.0, 14676.0, 14744.410223591043, 14910.776338354934, 14952.925235373754, 15160.393584256617, 11936.582219622358, 11940.0, 12296.262224266573, 12472.937635311766, 12892.162009469355, 3750.7374483786148, 3800.9809950950344, 3984.561698213194, 4114.691398145151, 4121.031557583995, 109521.0, 115826.0, 117574.41212793882, 118077.40961295138, 121305.0, 11062.506561614078, 11469.88530114705, 11503.252288601214, 11638.243514171552, 11640.941795291139, 23600.173993910474, 23989.160379386638, 24008.51982960331, 24017.759822401902, 24031.399215019414, 8185.263326300662, 8225.917740822635, 8226.629801658939, 8278.420704506158, 8337.207965243293, 4653.464851542116, 4668.463126740468, 4697.436307643105, 4709.458412282563, 4781.593564546983, 3368.7473439492137, 3447.517347571342, 3470.5661792275964, 3474.496198051319, 3475.669811367916, 624.2010226909563, 646.6734299178885, 647.6696884588894, 660.5442244851133, 668.9464842812563, 671.5265737655039, 703.3880523944201, 708.6279703155884, 722.9674664639998, 771.5255118102326, 10437.739056523647, 10897.891021089847, 10949.343039417661, 11048.668539943814, 11221.438928053727, 731.1336066760905, 743.8990294364371, 760.1828034862544, 768.2267016071976, 773.9961300193463, 4607.963208278111, 4929.3345398371475, 5147.0, 5255.421903590602, 5266.183741520071, 106753.0, 107942.92057079329, 109279.45360273148, 112595.43702281437, 113226.86773132328, 72793.27206727865, 92535.53732231431, 93882.0611793887, 95952.0, 96733.5163324193, 80636.59681701788, 80687.0, 82599.5870020658, 83450.58274708588, 84011.99999999878, 10128.446208797257, 10243.7439064024, 10296.639617613348, 10340.276180667583, 10428.217883658604, 47271.0, 52872.471275286756, 52963.0, 54447.45552544424, 55411.0, 52729.0, 68146.0, 69311.30688693048, 70244.0, 70878.93681594677, 11538.711532211762, 11569.132315076235, 11606.187566870576, 11861.288322700666, 12069.155159139127, 11835.349055802013, 12514.561990330294, 13126.40931158081, 13522.729545409233, 13556.051076424556, 12139.0, 12149.392530373623, 12509.624711258677, 12832.29422381778, 12897.226166430044, 11872.0, 11878.227915185485, 12319.876801231872, 12663.353764010988, 12674.0, 12093.153479256367, 12128.514859405524, 12136.211146275464, 12201.20692155007, 12250.326232057323, 6994.895076573957, 8108.554029528196, 8538.103499132501, 8723.171298726611, 8850.468971861708, 9672.93597704266, 10203.540840662337, 10356.53395597215, 10369.325993810378, 10406.167506599606], "value": 7841.244772431188, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1442.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 114.0, 114.0, 115.0, 123.0, 133.0, 114.0, 115.0], "value": 117.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 125.0, 109.0, 149.0, 124.0, 110.0, 108.0, 106.0, 124.0, 93.0], "value": 121.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 184.0, 184.0, 185.0, 185.0, 186.0, 186.0, 185.0, 187.0], "value": 185.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 61.0, 69.0, 96.0, 61.0, 59.0, 60.0, 62.0, 66.0, 59.0], "value": 67.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 68.0, 86.0, 69.0, 70.0, 67.0, 81.0, 67.0, 68.0, 82.0], "value": 74.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 110.0, 134.0, 87.0, 86.0, 87.0, 87.0, 87.0, 86.0], "value": 91.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 86.0, 94.0, 139.0, 138.0, 73.0, 129.0, 138.0], "value": 105.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 61.0, 65.0, 62.0, 65.0, 62.0, 65.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 65.0, 64.0, 66.0, 61.0, 58.0, 59.0, 58.0, 59.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 85.0, 84.0, 82.0, 84.0, 88.0, 85.0, 107.0, 95.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 134.0, 133.0, 127.0, 141.0, 148.0, 142.0, 150.0, 134.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 223.0, 206.0, 163.0, 159.0, 163.0, 161.0, 160.0, 161.0, 163.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 63.0, 65.0, 64.0, 64.0, 64.0, 63.0, 63.0], "value": 64.0, "unit": "score"}]}]} 08:47:17 INFO - Return code: 0 08:47:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:47:17 INFO - # TBPL SUCCESS # 08:47:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:47:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:47:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:47:17 INFO - 2017-04-26 08:47:17.903 screenresolution[3321:313996] starting screenresolution argv=screenresolution get 08:47:17 INFO - 2017-04-26 08:47:17.905 screenresolution[3321:313996] Display 0: 1600x1200x32@60 08:47:17 INFO - 2017-04-26 08:47:17.911 screenresolution[3322:313999] starting screenresolution argv=screenresolution list 08:47:17 INFO - Available Modes on Display 0 08:47:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:47:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:47:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:47:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:47:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:47:18 INFO - Intel Iris: 08:47:18 INFO - Chipset Model: Intel Iris 08:47:18 INFO - Type: GPU 08:47:18 INFO - Bus: Built-In 08:47:18 INFO - VRAM (Dynamic, Max): 1536 MB 08:47:18 INFO - Vendor: Intel (0x8086) 08:47:18 INFO - Device ID: 0x0a2e 08:47:18 INFO - Revision ID: 0x0009 08:47:18 INFO - Displays: 08:47:18 INFO - Display: 08:47:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:47:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:47:18 INFO - Display Serial Number: 1600x1200 60 08:47:18 INFO - Main Display: Yes 08:47:18 INFO - Mirror: Off 08:47:18 INFO - Online: Yes 08:47:18 INFO - Rotation: Supported 08:47:18 INFO - Return code: 0 08:47:18 INFO - Running post-action listener: _resource_record_post_action 08:47:18 INFO - [mozharness: 2017-04-26 15:47:18.149653Z] Finished run-tests step (success) 08:47:18 INFO - Running post-run listener: _resource_record_post_run 08:47:18 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 106496; Write bytes: 420242432; Read time: 1; Write time: 1704 08:47:18 INFO - TinderboxPrint: CPU usage
53.7% 08:47:18 INFO - TinderboxPrint: I/O read bytes / time
106,496 / 1 08:47:18 INFO - TinderboxPrint: I/O write bytes / time
420,242,432 / 1,704 08:47:18 INFO - TinderboxPrint: CPU idle
2,212.2 (46.3%) 08:47:18 INFO - TinderboxPrint: CPU system
953.8 (20.0%) 08:47:18 INFO - TinderboxPrint: CPU user
1,611.7 (33.7%) 08:47:18 INFO - TinderboxPrint: Swap in / out
121,446,400 / 0 08:47:18 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121383424; Write bytes: 117209088; Read time: 11025; Write time: 419 08:47:18 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 94208; Write bytes: 293014528; Read time: 1; Write time: 1253 08:47:18 INFO - Running post-run listener: _upload_blobber_files 08:47:18 INFO - Blob upload gear active. 08:47:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:47:18 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 08:47:18 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:47:18 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:47:19 INFO - (blobuploader) - INFO - Open directory for files ... 08:47:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:47:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:47:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:20 INFO - (blobuploader) - INFO - Done attempting. 08:47:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:47:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:47:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:21 INFO - (blobuploader) - INFO - Done attempting. 08:47:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:47:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:47:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:22 INFO - (blobuploader) - INFO - Done attempting. 08:47:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:47:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:47:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:23 INFO - (blobuploader) - INFO - Done attempting. 08:47:23 INFO - (blobuploader) - INFO - Iteration through files over. 08:47:23 INFO - Return code: 0 08:47:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:47:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:47:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e1e2b7e252e0e7e11910faed457b5ca4def5adbcd877c076cfaa8558ef256395d747a0894c5b5f860b1d9b0ab81fece543fc8f4ae5164ee6e4e2bb98635a311", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0052efdc3d80da52e26f28da10d59b3fc20a9ecba3cc06bfb310725aa798aeeed7aa5fccf2de572cd2599912060792e72c9b21e3113b28db46362abf5890a6e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4be169705ca27a0d2ae9b242e2b0e2f7ebcb76fbafbd685763c3743a7ece661608a4d8c8e0018f88aca3bd6ac1e160c32fdd020e095dfd185717eff886cd321", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36e11199d89e3bb22a79fd3d169f1c98fa54a27a33f75b79ce35740ee45e6f92e713688e0af62acdadd2ad0bc86886a7bb95d5fc6d836cfb8e33a7632267de7c"} 08:47:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:47:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:47:23 INFO - Contents: 08:47:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e1e2b7e252e0e7e11910faed457b5ca4def5adbcd877c076cfaa8558ef256395d747a0894c5b5f860b1d9b0ab81fece543fc8f4ae5164ee6e4e2bb98635a311", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0052efdc3d80da52e26f28da10d59b3fc20a9ecba3cc06bfb310725aa798aeeed7aa5fccf2de572cd2599912060792e72c9b21e3113b28db46362abf5890a6e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4be169705ca27a0d2ae9b242e2b0e2f7ebcb76fbafbd685763c3743a7ece661608a4d8c8e0018f88aca3bd6ac1e160c32fdd020e095dfd185717eff886cd321", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36e11199d89e3bb22a79fd3d169f1c98fa54a27a33f75b79ce35740ee45e6f92e713688e0af62acdadd2ad0bc86886a7bb95d5fc6d836cfb8e33a7632267de7c"} 08:47:23 INFO - Running post-run listener: copy_logs_to_upload_dir 08:47:23 INFO - Copying logs to upload dir... 08:47:23 INFO - mkdir: /builds/slave/test/build/upload/logs 08:47:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.341902 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-26 08:47:24.066717) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 08:47:24.070760) ========= 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.2ZgPZIDCJE/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.pFoO11jCby/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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/Mozilla-Beta/sha512/7e1e2b7e252e0e7e11910faed457b5ca4def5adbcd877c076cfaa8558ef256395d747a0894c5b5f860b1d9b0ab81fece543fc8f4ae5164ee6e4e2bb98635a311", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0052efdc3d80da52e26f28da10d59b3fc20a9ecba3cc06bfb310725aa798aeeed7aa5fccf2de572cd2599912060792e72c9b21e3113b28db46362abf5890a6e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4be169705ca27a0d2ae9b242e2b0e2f7ebcb76fbafbd685763c3743a7ece661608a4d8c8e0018f88aca3bd6ac1e160c32fdd020e095dfd185717eff886cd321", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36e11199d89e3bb22a79fd3d169f1c98fa54a27a33f75b79ce35740ee45e6f92e713688e0af62acdadd2ad0bc86886a7bb95d5fc6d836cfb8e33a7632267de7c"} build_url:https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/WA3PlrOeT_290nz5UHEV9A/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e1e2b7e252e0e7e11910faed457b5ca4def5adbcd877c076cfaa8558ef256395d747a0894c5b5f860b1d9b0ab81fece543fc8f4ae5164ee6e4e2bb98635a311", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0052efdc3d80da52e26f28da10d59b3fc20a9ecba3cc06bfb310725aa798aeeed7aa5fccf2de572cd2599912060792e72c9b21e3113b28db46362abf5890a6e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4be169705ca27a0d2ae9b242e2b0e2f7ebcb76fbafbd685763c3743a7ece661608a4d8c8e0018f88aca3bd6ac1e160c32fdd020e095dfd185717eff886cd321", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36e11199d89e3bb22a79fd3d169f1c98fa54a27a33f75b79ce35740ee45e6f92e713688e0af62acdadd2ad0bc86886a7bb95d5fc6d836cfb8e33a7632267de7c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 08:47:24.107571) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 08:47:24.108183) ========= 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.2ZgPZIDCJE/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.pFoO11jCby/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005114 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 08:47:24.158592) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 08:47:24.158954) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 08:47:24.159358) ========= ========= Total master_lag: 3.83 =========