builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0262 starttime: 1486386098.94 results: success (0) buildid: 20170206020150 builduid: 2990e3e5e59640658dabab5fb28321ef revision: 06eda6a9a51fa6a6d2d2e38b178d4bf009891a77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 05:01:38.936960) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 05:01:38.937715) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 05:01:38.938220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 05:01:38.974185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 05:01:38.974514) ========= 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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-06 05:01:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.3M=0s 2017-02-06 05:01:39 (28.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126053 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 05:01:39.132692) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 05:01:39.133019) ========= 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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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.024852 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 05:01:39.183112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-06 05:01:39.183452) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 06eda6a9a51fa6a6d2d2e38b178d4bf009891a77 --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 06eda6a9a51fa6a6d2d2e38b178d4bf009891a77 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gMHOsXPdlV/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.Nrki7cVLJF/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-06 05:01:39,291 truncating revision to first 12 chars 2017-02-06 05:01:39,291 Setting DEBUG logging. 2017-02-06 05:01:39,292 attempt 1/10 2017-02-06 05:01:39,292 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/06eda6a9a51f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 05:01:41,152 unpacking tar archive at: mozilla-beta-06eda6a9a51f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.134347 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-06 05:01:41.341750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 05:01:41.342087) ========= script_repo_revision: 06eda6a9a51fa6a6d2d2e38b178d4bf009891a77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 05:01:41.342498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 05:01:41.342830) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 05:01:41.363493) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-06 05:01:41.363930) ========= /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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 05:01:41 INFO - MultiFileLogger online at 20170206 05:01:41 in /builds/slave/test 05:01:41 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 05:01:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:01:41 INFO - {'append_to_log': False, 05:01:41 INFO - 'base_work_dir': '/builds/slave/test', 05:01:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:01:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:01:41 INFO - 'branch': 'Mozilla-Beta', 05:01:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:41 INFO - 'config_files': ('talos/mac_config.py',), 05:01:41 INFO - 'default_actions': ('clobber', 05:01:41 INFO - 'read-buildbot-config', 05:01:41 INFO - 'download-and-extract', 05:01:41 INFO - 'populate-webroot', 05:01:41 INFO - 'create-virtualenv', 05:01:41 INFO - 'install', 05:01:41 INFO - 'run-tests'), 05:01:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:41 INFO - 'download_minidump_stackwalk': True, 05:01:41 INFO - 'download_symbols': 'ondemand', 05:01:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:41 INFO - 'installer_path': 'installer.exe', 05:01:41 INFO - 'log_level': 'info', 05:01:41 INFO - 'log_name': 'talos', 05:01:41 INFO - 'log_to_console': True, 05:01:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:01:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:01:41 INFO - 'opt_config_files': (), 05:01:41 INFO - 'pip_index': False, 05:01:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:01:41 INFO - 'cmd': ('bash', 05:01:41 INFO - '-c', 05:01:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:01:41 INFO - 'enabled': True, 05:01:41 INFO - 'halt_on_failure': False, 05:01:41 INFO - 'name': 'check_screen_resolution'},), 05:01:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:01:41 INFO - 'cmd': ('bash', 05:01:41 INFO - '-c', 05:01:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:01:41 INFO - 'enabled': True, 05:01:41 INFO - 'halt_on_failure': False, 05:01:41 INFO - 'name': 'check_screen_resolution'},), 05:01:41 INFO - 'run_cmd_checks_enabled': True, 05:01:41 INFO - 'sps_profile': False, 05:01:41 INFO - 'sps_profile_interval': 0, 05:01:41 INFO - 'suite': 'dromaeojs', 05:01:41 INFO - 'system_bits': '32', 05:01:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:41 INFO - 'title': 't-yosemite-r7-0262', 05:01:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:41 INFO - 'use_talos_json': True, 05:01:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:01:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:41 INFO - 'work_dir': 'build'} 05:01:41 INFO - [mozharness: 2017-02-06 13:01:41.580486Z] Running clobber step. 05:01:41 INFO - Running pre-action listener: _resource_record_pre_action 05:01:41 INFO - Running main action method: clobber 05:01:41 INFO - rmtree: /builds/slave/test/build 05:01:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:01:43 INFO - Running post-action listener: _resource_record_post_action 05:01:43 INFO - [mozharness: 2017-02-06 13:01:43.949460Z] Finished clobber step (success) 05:01:43 INFO - [mozharness: 2017-02-06 13:01:43.949619Z] Running read-buildbot-config step. 05:01:43 INFO - Running pre-action listener: _resource_record_pre_action 05:01:43 INFO - Running main action method: read_buildbot_config 05:01:43 INFO - Using buildbot properties: 05:01:43 INFO - { 05:01:43 INFO - "project": "", 05:01:43 INFO - "product": "firefox", 05:01:43 INFO - "script_repo_revision": "production", 05:01:43 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:01:43 INFO - "repository": "", 05:01:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:01:43 INFO - "buildid": "20170206020150", 05:01:43 INFO - "pgo_build": "False", 05:01:43 INFO - "basedir": "/builds/slave/test", 05:01:43 INFO - "buildnumber": 1, 05:01:43 INFO - "slavename": "t-yosemite-r7-0262", 05:01:43 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:01:43 INFO - "platform": "yosemite_r7", 05:01:43 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:01:43 INFO - "branch": "mozilla-beta", 05:01:43 INFO - "repo_path": "releases/mozilla-beta", 05:01:43 INFO - "revision": "06eda6a9a51fa6a6d2d2e38b178d4bf009891a77", 05:01:43 INFO - "stage_platform": "macosx64", 05:01:43 INFO - "builduid": "2990e3e5e59640658dabab5fb28321ef", 05:01:43 INFO - "slavebuilddir": "test" 05:01:43 INFO - } 05:01:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 05:01:43 INFO - Running post-action listener: _resource_record_post_action 05:01:43 INFO - [mozharness: 2017-02-06 13:01:43.952970Z] Finished read-buildbot-config step (success) 05:01:43 INFO - [mozharness: 2017-02-06 13:01:43.953101Z] Running download-and-extract step. 05:01:43 INFO - Running pre-action listener: _resource_record_pre_action 05:01:43 INFO - Running main action method: download_and_extract 05:01:43 INFO - mkdir: /builds/slave/test/build/tests 05:01:43 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')]} 05:01:43 INFO - trying https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 05:01:43 INFO - Downloading https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 05:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 05:01:44 INFO - Downloaded 1165 bytes. 05:01:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 05:01:44 INFO - Using the following test package requirements: 05:01:44 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 05:01:44 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:01:44 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 05:01:44 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:01:44 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 05:01:44 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:01:44 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:01:44 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 05:01:44 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 05:01:44 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:01:44 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 05:01:44 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:01:44 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 05:01:44 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:01:44 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 05:01:44 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 05:01:44 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 05:01:44 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 05:01:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 05:01:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 05:01:44 INFO - Fetch https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 05:01:45 INFO - Http code: 200 05:01:45 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 05:01:45 INFO - x-amz-cf-id: Agkol3Kpg-_OPyV3oLgAbop6VssN9EHX6yVTe8S3cz84m6x-_LkZgA== 05:01:45 INFO - x-amz-version-id: GxNAr34xJgRESZCKo4XdoPcSit7KbN.O 05:01:45 INFO - Expected file size: 16091819 05:01:45 INFO - Obtained file size: 16091819 05:01:52 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:01:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 05:01:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 05:01:52 INFO - Fetch https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 05:01:52 INFO - Http code: 200 05:01:52 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 05:01:52 INFO - x-amz-cf-id: oUiduoDvgZKJA8ub9AsJ7VRG8pEO7HT4v4x8LMeSVWL4oHbQDU7I7w== 05:01:52 INFO - x-amz-version-id: GxNAr34xJgRESZCKo4XdoPcSit7KbN.O 05:01:52 INFO - Expected file size: 16091819 05:01:52 INFO - Obtained file size: 16091819 05:01:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 05:01:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 05:01:59 INFO - Fetch https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 05:01:59 INFO - Http code: 200 05:01:59 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 05:01:59 INFO - x-amz-cf-id: hv8gbsrtGGLX7kSiOMvQyy5xERIAnKGqBU5k3R4ahwkkr7rkahdcGQ== 05:01:59 INFO - x-amz-version-id: Q6vEL3t_no_6KDt2Iy6GkBjwn8sypxko 05:02:00 INFO - Expected file size: 14403005 05:02:00 INFO - Obtained file size: 14403005 05:02:00 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')]} 05:02:00 INFO - trying https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.dmg 05:02:00 INFO - Downloading https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 05:02:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 05:02:03 INFO - Downloaded 82136602 bytes. 05:02:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.dmg 05:02:03 INFO - mkdir: /builds/slave/test/properties 05:02:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:02:03 INFO - Writing to file /builds/slave/test/properties/build_url 05:02:03 INFO - Contents: 05:02:03 INFO - build_url:https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.dmg 05:02:03 INFO - Running post-action listener: _resource_record_post_action 05:02:03 INFO - Running post-action listener: set_extra_try_arguments 05:02:03 INFO - [mozharness: 2017-02-06 13:02:03.712420Z] Finished download-and-extract step (success) 05:02:03 INFO - [mozharness: 2017-02-06 13:02:03.712514Z] Running populate-webroot step. 05:02:03 INFO - Running pre-action listener: _resource_record_pre_action 05:02:03 INFO - Running main action method: populate_webroot 05:02:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:02:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:02:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:02:03 INFO - '--tppagecycles', 05:02:03 INFO - '7'], 05:02:03 INFO - 'tests': ['tsvgm']}}, 05:02:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:02:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:02:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:02:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:02:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:02:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:02:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:03 INFO - 'talos_options': ['--disable-e10s'], 05:02:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:03 INFO - 'talos_options': ['--disable-e10s'], 05:02:03 INFO - 'tests': ['damp', 'tps']}, 05:02:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:03 INFO - 'tests': ['damp', 'tps']}, 05:02:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:02:03 INFO - 'tests': ['dromaeo_dom']}, 05:02:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:02:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:02:03 INFO - 'tests': ['basic_compositor_video']}, 05:02:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:02:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:02:03 INFO - 'tests': ['a11yr', 05:02:03 INFO - 'ts_paint', 05:02:03 INFO - 'tpaint', 05:02:03 INFO - 'sessionrestore', 05:02:03 INFO - 'sessionrestore_no_auto_restore', 05:02:03 INFO - 'tabpaint']}, 05:02:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:02:03 INFO - 'ts_paint', 05:02:03 INFO - 'tpaint', 05:02:03 INFO - 'sessionrestore', 05:02:03 INFO - 'sessionrestore_no_auto_restore', 05:02:03 INFO - 'tabpaint']}, 05:02:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:02:03 INFO - 'ts_paint', 05:02:03 INFO - 'tpaint', 05:02:03 INFO - 'sessionrestore', 05:02:03 INFO - 'sessionrestore_no_auto_restore', 05:02:03 INFO - 'tabpaint']}, 05:02:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:02:03 INFO - 'ts_paint', 05:02:03 INFO - 'tpaint', 05:02:03 INFO - 'sessionrestore', 05:02:03 INFO - 'sessionrestore_no_auto_restore', 05:02:03 INFO - 'tabpaint']}, 05:02:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:02:03 INFO - 'tests': ['a11yr', 05:02:03 INFO - 'ts_paint', 05:02:03 INFO - 'tpaint', 05:02:03 INFO - 'sessionrestore', 05:02:03 INFO - 'sessionrestore_no_auto_restore', 05:02:03 INFO - 'tabpaint']}, 05:02:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:02:03 INFO - 'tests': ['a11yr', 05:02:03 INFO - 'ts_paint', 05:02:03 INFO - 'tpaint', 05:02:03 INFO - 'sessionrestore', 05:02:03 INFO - 'sessionrestore_no_auto_restore', 05:02:03 INFO - 'tabpaint']}, 05:02:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:02:03 INFO - 'tests': ['tsvgx', 05:02:03 INFO - 'tsvgr_opacity', 05:02:03 INFO - 'tart', 05:02:03 INFO - 'tscrollx', 05:02:03 INFO - 'cart']}, 05:02:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:02:03 INFO - 'tsvgr_opacity', 05:02:03 INFO - 'tart', 05:02:03 INFO - 'tscrollx', 05:02:03 INFO - 'cart']}, 05:02:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:03 INFO - 'talos_options': ['--disable-e10s'], 05:02:03 INFO - 'tests': ['tp5o']}, 05:02:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:03 INFO - 'tests': ['tp5o']}, 05:02:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:03 INFO - 'talos_options': ['--disable-e10s', 05:02:03 INFO - '--xperf_path', 05:02:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:03 INFO - 'tests': ['tp5n']}, 05:02:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:03 INFO - 'talos_options': ['--xperf_path', 05:02:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:03 INFO - 'tests': ['tp5n']}}, 05:02:03 INFO - 'talos.zip': {'path': '', 05:02:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:02:03 INFO - Running post-action listener: _resource_record_post_action 05:02:03 INFO - [mozharness: 2017-02-06 13:02:03.730960Z] Finished populate-webroot step (success) 05:02:03 INFO - [mozharness: 2017-02-06 13:02:03.731073Z] Running create-virtualenv step. 05:02:03 INFO - Running pre-action listener: _resource_record_pre_action 05:02:03 INFO - Running main action method: create_virtualenv 05:02:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:02:03 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 05:02:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:02:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:02:03 INFO - Using real prefix '/tools/python27' 05:02:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:02:04 INFO - Installing distribute.............................................................................................................................................................................................done. 05:02:07 INFO - Installing pip.................done. 05:02:07 INFO - Return code: 0 05:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:02:07 INFO - Reading from file tmpfile_stdout 05:02:07 INFO - Output received: 05:02:07 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) 05:02:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105be5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f59c7e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f9d30>, '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 0x10585fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059f1b20>, '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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 05:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:02:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gMHOsXPdlV/Render', 05:02:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:07 INFO - 'HOME': '/Users/cltbld', 05:02:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:07 INFO - 'LOGNAME': 'cltbld', 05:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:07 INFO - 'MOZ_NO_REMOTE': '1', 05:02:07 INFO - 'NO_EM_RESTART': '1', 05:02:07 INFO - 'PAGER': '/bin/cat', 05:02:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:07 INFO - 'PWD': '/builds/slave/test', 05:02:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:07 INFO - 'SHELL': '/bin/bash', 05:02:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nrki7cVLJF/Listeners', 05:02:07 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 05:02:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:07 INFO - 'USER': 'cltbld', 05:02:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:07 INFO - 'XPC_FLAGS': '0x0', 05:02:07 INFO - 'XPC_SERVICE_NAME': '0', 05:02:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:07 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 05:02:07 INFO - Cleaning up... 05:02:07 INFO - Return code: 0 05:02:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105be5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f59c7e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f9d30>, '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 0x10585fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059f1b20>, '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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 05:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:02:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gMHOsXPdlV/Render', 05:02:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:07 INFO - 'HOME': '/Users/cltbld', 05:02:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:07 INFO - 'LOGNAME': 'cltbld', 05:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:07 INFO - 'MOZ_NO_REMOTE': '1', 05:02:07 INFO - 'NO_EM_RESTART': '1', 05:02:07 INFO - 'PAGER': '/bin/cat', 05:02:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:07 INFO - 'PWD': '/builds/slave/test', 05:02:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:07 INFO - 'SHELL': '/bin/bash', 05:02:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nrki7cVLJF/Listeners', 05:02:07 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 05:02:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:07 INFO - 'USER': 'cltbld', 05:02:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:07 INFO - 'XPC_FLAGS': '0x0', 05:02:07 INFO - 'XPC_SERVICE_NAME': '0', 05:02:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:08 INFO - Downloading/unpacking psutil>=3.1.1 05:02:08 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 05:02:08 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 05:02:08 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 05:02:08 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 05:02:08 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 05:02:08 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 05:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:02:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:12 INFO - Installing collected packages: psutil 05:02:12 INFO - Running setup.py install for psutil 05:02:12 INFO - building 'psutil._psutil_osx' extension 05:02:12 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 05:02:13 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 05:02:13 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 05:02:13 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 05:02:13 INFO - building 'psutil._psutil_posix' extension 05:02:13 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 05:02:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:02:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:02:13 INFO - ^ 05:02:13 INFO - 1 warning generated. 05:02:13 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 05:02:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:13 INFO - Successfully installed psutil 05:02:13 INFO - Cleaning up... 05:02:13 INFO - Return code: 0 05:02:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105be5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f59c7e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f9d30>, '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 0x10585fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059f1b20>, '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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 05:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:02:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gMHOsXPdlV/Render', 05:02:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:13 INFO - 'HOME': '/Users/cltbld', 05:02:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:13 INFO - 'LOGNAME': 'cltbld', 05:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:13 INFO - 'MOZ_NO_REMOTE': '1', 05:02:13 INFO - 'NO_EM_RESTART': '1', 05:02:13 INFO - 'PAGER': '/bin/cat', 05:02:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:13 INFO - 'PWD': '/builds/slave/test', 05:02:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:13 INFO - 'SHELL': '/bin/bash', 05:02:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nrki7cVLJF/Listeners', 05:02:13 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 05:02:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:13 INFO - 'USER': 'cltbld', 05:02:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:13 INFO - 'XPC_FLAGS': '0x0', 05:02:13 INFO - 'XPC_SERVICE_NAME': '0', 05:02:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:02:13 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 05:02:13 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 05:02:13 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 05:02:13 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 05:02:13 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 05:02:13 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 05:02:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:02:16 INFO - Installing collected packages: mozsystemmonitor 05:02:16 INFO - Running setup.py install for mozsystemmonitor 05:02:16 INFO - Successfully installed mozsystemmonitor 05:02:16 INFO - Cleaning up... 05:02:16 INFO - Return code: 0 05:02:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:16 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 0x105be5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f59c7e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f9d30>, '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 0x10585fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059f1b20>, '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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 05:02:16 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 05:02:16 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 05:02:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gMHOsXPdlV/Render', 05:02:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:16 INFO - 'HOME': '/Users/cltbld', 05:02:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:16 INFO - 'LOGNAME': 'cltbld', 05:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:16 INFO - 'MOZ_NO_REMOTE': '1', 05:02:16 INFO - 'NO_EM_RESTART': '1', 05:02:16 INFO - 'PAGER': '/bin/cat', 05:02:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:16 INFO - 'PWD': '/builds/slave/test', 05:02:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:16 INFO - 'SHELL': '/bin/bash', 05:02:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nrki7cVLJF/Listeners', 05:02:16 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 05:02:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:16 INFO - 'USER': 'cltbld', 05:02:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:16 INFO - 'XPC_FLAGS': '0x0', 05:02:16 INFO - 'XPC_SERVICE_NAME': '0', 05:02:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:17 INFO - Downloading/unpacking jsonschema==2.5.1 05:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:02:19 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 05:02:19 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 05:02:19 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 05:02:19 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 05:02:19 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 05:02:19 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 05:02:20 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:20 INFO - warning: no files found matching '*.txt' 05:02:20 INFO - no previously-included directories found matching 'build' 05:02:20 INFO - no previously-included directories found matching 'dist' 05:02:20 INFO - no previously-included directories found matching '.git*' 05:02:20 INFO - Installing collected packages: jsonschema, functools32 05:02:20 INFO - Running setup.py install for functools32 05:02:20 INFO - warning: no files found matching '*.txt' 05:02:20 INFO - no previously-included directories found matching 'build' 05:02:20 INFO - no previously-included directories found matching 'dist' 05:02:20 INFO - no previously-included directories found matching '.git*' 05:02:20 INFO - Successfully installed jsonschema functools32 05:02:20 INFO - Cleaning up... 05:02:20 INFO - Return code: 0 05:02:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105be5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f59c7e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f9d30>, '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 0x10585fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059f1b20>, '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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 05:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:02:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gMHOsXPdlV/Render', 05:02:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:20 INFO - 'HOME': '/Users/cltbld', 05:02:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:20 INFO - 'LOGNAME': 'cltbld', 05:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:20 INFO - 'MOZ_NO_REMOTE': '1', 05:02:20 INFO - 'NO_EM_RESTART': '1', 05:02:20 INFO - 'PAGER': '/bin/cat', 05:02:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:20 INFO - 'PWD': '/builds/slave/test', 05:02:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:20 INFO - 'SHELL': '/bin/bash', 05:02:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nrki7cVLJF/Listeners', 05:02:20 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 05:02:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:20 INFO - 'USER': 'cltbld', 05:02:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:20 INFO - 'XPC_FLAGS': '0x0', 05:02:20 INFO - 'XPC_SERVICE_NAME': '0', 05:02:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:02:20 INFO - Cleaning up... 05:02:20 INFO - Return code: 0 05:02:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105be5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f59c7e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f9d30>, '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 0x10585fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059f1b20>, '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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 05:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:02:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gMHOsXPdlV/Render', 05:02:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:20 INFO - 'HOME': '/Users/cltbld', 05:02:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:20 INFO - 'LOGNAME': 'cltbld', 05:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:20 INFO - 'MOZ_NO_REMOTE': '1', 05:02:20 INFO - 'NO_EM_RESTART': '1', 05:02:20 INFO - 'PAGER': '/bin/cat', 05:02:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:20 INFO - 'PWD': '/builds/slave/test', 05:02:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:20 INFO - 'SHELL': '/bin/bash', 05:02:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nrki7cVLJF/Listeners', 05:02:20 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 05:02:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:20 INFO - 'USER': 'cltbld', 05:02:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:20 INFO - 'XPC_FLAGS': '0x0', 05:02:20 INFO - 'XPC_SERVICE_NAME': '0', 05:02:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:23 INFO - Downloading blobuploader-1.2.4.tar.gz 05:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:02:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:02:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:25 INFO - Downloading docopt-0.6.1.tar.gz 05:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:02:25 INFO - Installing collected packages: blobuploader, requests, docopt 05:02:25 INFO - Running setup.py install for blobuploader 05:02:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:02:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:02:25 INFO - Running setup.py install for requests 05:02:25 INFO - Running setup.py install for docopt 05:02:25 INFO - Successfully installed blobuploader requests docopt 05:02:25 INFO - Cleaning up... 05:02:26 INFO - Return code: 0 05:02:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:26 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 0x105be5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f59c7e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f9d30>, '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 0x10585fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059f1b20>, '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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 05:02:26 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 05:02:26 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 05:02:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gMHOsXPdlV/Render', 05:02:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:26 INFO - 'HOME': '/Users/cltbld', 05:02:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:26 INFO - 'LOGNAME': 'cltbld', 05:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:26 INFO - 'MOZ_NO_REMOTE': '1', 05:02:26 INFO - 'NO_EM_RESTART': '1', 05:02:26 INFO - 'PAGER': '/bin/cat', 05:02:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:26 INFO - 'PWD': '/builds/slave/test', 05:02:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:26 INFO - 'SHELL': '/bin/bash', 05:02:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nrki7cVLJF/Listeners', 05:02:26 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 05:02:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:26 INFO - 'USER': 'cltbld', 05:02:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:26 INFO - 'XPC_FLAGS': '0x0', 05:02:26 INFO - 'XPC_SERVICE_NAME': '0', 05:02:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-E6ECrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-2hHBAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-oOCk6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-i5yilV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-x987o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-N33E69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:26 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-pkVC3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Y00pcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-iAInRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-62wf6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-7vorPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-vwwJ7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-KVaT93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-hYe0ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-gxXKXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-iiAkir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:27 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-V1zYK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:02:28 INFO - Running setup.py install for manifestparser 05:02:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:02:28 INFO - Running setup.py install for mozcrash 05:02:28 INFO - Running setup.py install for mozdebug 05:02:28 INFO - Running setup.py install for mozdevice 05:02:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:02:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:02:28 INFO - Running setup.py install for mozfile 05:02:28 INFO - Running setup.py install for mozhttpd 05:02:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:02:28 INFO - Running setup.py install for mozinfo 05:02:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:02:29 INFO - Running setup.py install for mozInstall 05:02:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:02:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:02:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:02:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:02:29 INFO - Running setup.py install for mozleak 05:02:29 INFO - Running setup.py install for mozlog 05:02:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:02:29 INFO - Running setup.py install for moznetwork 05:02:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:02:29 INFO - Running setup.py install for mozprocess 05:02:29 INFO - Running setup.py install for mozprofile 05:02:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:02:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:02:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:02:30 INFO - Running setup.py install for mozrunner 05:02:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:02:30 INFO - Running setup.py install for mozscreenshot 05:02:30 INFO - Running setup.py install for moztest 05:02:30 INFO - Running setup.py install for mozversion 05:02:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:02:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:02:30 INFO - Cleaning up... 05:02:30 INFO - Return code: 0 05:02:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:30 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')]} 05:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:30 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')]} 05:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:30 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 0x105be5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f59c7e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f9d30>, '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 0x10585fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059f1b20>, '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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 05:02:30 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 05:02:30 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 05:02:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gMHOsXPdlV/Render', 05:02:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:30 INFO - 'HOME': '/Users/cltbld', 05:02:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:30 INFO - 'LOGNAME': 'cltbld', 05:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:30 INFO - 'MOZ_NO_REMOTE': '1', 05:02:30 INFO - 'NO_EM_RESTART': '1', 05:02:30 INFO - 'PAGER': '/bin/cat', 05:02:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:30 INFO - 'PWD': '/builds/slave/test', 05:02:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:30 INFO - 'SHELL': '/bin/bash', 05:02:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nrki7cVLJF/Listeners', 05:02:30 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 05:02:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:30 INFO - 'USER': 'cltbld', 05:02:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:30 INFO - 'XPC_FLAGS': '0x0', 05:02:30 INFO - 'XPC_SERVICE_NAME': '0', 05:02:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:30 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-zVRry3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:31 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)) 05:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-_FQff6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:31 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)) 05:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Ukq_9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:31 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)) 05:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Nc4cwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-PQ9pp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:31 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)) 05:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-TS95hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:31 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)) 05:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-5yxhqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:31 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)) 05:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-9q_1uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:31 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)) 05:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-dZoWBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:31 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)) 05:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Sc2jAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:32 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)) 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-1Vnn2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:32 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)) 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-ZbREHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-3EAoOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:32 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)) 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-4HfNE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:32 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)) 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-hVywdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:32 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)) 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-dpcs9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:32 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)) 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-mAz4Iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:32 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)) 05:02:32 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)) 05:02:32 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)) 05:02:32 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)) 05:02:32 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:32 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:02:32 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 05:02:32 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 05:02:32 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 05:02:32 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 05:02:32 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 05:02:32 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 05:02:35 INFO - Downloading blessings-1.6.tar.gz 05:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:02:35 INFO - Installing collected packages: blessings 05:02:35 INFO - Running setup.py install for blessings 05:02:35 INFO - Successfully installed blessings 05:02:35 INFO - Cleaning up... 05:02:35 INFO - Return code: 0 05:02:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:02:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:36 INFO - Reading from file tmpfile_stdout 05:02:36 INFO - Current package versions: 05:02:36 INFO - blessings == 1.6 05:02:36 INFO - blobuploader == 1.2.4 05:02:36 INFO - docopt == 0.6.1 05:02:36 INFO - functools32 == 3.2.3-2 05:02:36 INFO - jsonschema == 2.5.1 05:02:36 INFO - manifestparser == 1.1 05:02:36 INFO - mozInstall == 1.12 05:02:36 INFO - mozcrash == 1.0 05:02:36 INFO - mozdebug == 0.1 05:02:36 INFO - mozdevice == 0.48 05:02:36 INFO - mozfile == 1.2 05:02:36 INFO - mozhttpd == 0.7 05:02:36 INFO - mozinfo == 0.9 05:02:36 INFO - mozleak == 0.1 05:02:36 INFO - mozlog == 3.4 05:02:36 INFO - moznetwork == 0.27 05:02:36 INFO - mozprocess == 0.23 05:02:36 INFO - mozprofile == 0.28 05:02:36 INFO - mozrunner == 6.13 05:02:36 INFO - mozscreenshot == 0.1 05:02:36 INFO - mozsystemmonitor == 0.3 05:02:36 INFO - moztest == 0.8 05:02:36 INFO - mozversion == 1.4 05:02:36 INFO - psutil == 3.1.1 05:02:36 INFO - requests == 1.2.3 05:02:36 INFO - wsgiref == 0.1.2 05:02:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:36 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')]} 05:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:36 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')]} 05:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:36 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 0x105be5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f59c7e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f9d30>, '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 0x10585fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059f1b20>, '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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 05:02:36 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 05:02:36 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 05:02:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gMHOsXPdlV/Render', 05:02:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:36 INFO - 'HOME': '/Users/cltbld', 05:02:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:36 INFO - 'LOGNAME': 'cltbld', 05:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:36 INFO - 'MOZ_NO_REMOTE': '1', 05:02:36 INFO - 'NO_EM_RESTART': '1', 05:02:36 INFO - 'PAGER': '/bin/cat', 05:02:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:36 INFO - 'PWD': '/builds/slave/test', 05:02:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:36 INFO - 'SHELL': '/bin/bash', 05:02:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nrki7cVLJF/Listeners', 05:02:36 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 05:02:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:36 INFO - 'USER': 'cltbld', 05:02:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:36 INFO - 'XPC_FLAGS': '0x0', 05:02:36 INFO - 'XPC_SERVICE_NAME': '0', 05:02:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 INFO - Cleaning up... 05:02:36 INFO - Return code: 0 05:02:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:02:36 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')]} 05:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:36 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')]} 05:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:36 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 0x105be5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f59c7e5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059f9d30>, '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 0x10585fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059f1b20>, '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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 05:02:36 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 05:02:36 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 05:02:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gMHOsXPdlV/Render', 05:02:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:36 INFO - 'HOME': '/Users/cltbld', 05:02:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:36 INFO - 'LOGNAME': 'cltbld', 05:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:36 INFO - 'MOZ_NO_REMOTE': '1', 05:02:36 INFO - 'NO_EM_RESTART': '1', 05:02:36 INFO - 'PAGER': '/bin/cat', 05:02:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:36 INFO - 'PWD': '/builds/slave/test', 05:02:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:36 INFO - 'SHELL': '/bin/bash', 05:02:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nrki7cVLJF/Listeners', 05:02:36 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 05:02:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:36 INFO - 'USER': 'cltbld', 05:02:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:36 INFO - 'XPC_FLAGS': '0x0', 05:02:36 INFO - 'XPC_SERVICE_NAME': '0', 05:02:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:02:36 INFO - Cleaning up... 05:02:36 INFO - Return code: 0 05:02:36 INFO - Running post-action listener: _resource_record_post_action 05:02:36 INFO - Running post-action listener: _start_resource_monitoring 05:02:36 INFO - Starting resource monitoring. 05:02:36 INFO - [mozharness: 2017-02-06 13:02:36.660416Z] Finished create-virtualenv step (success) 05:02:36 INFO - [mozharness: 2017-02-06 13:02:36.661320Z] Running install step. 05:02:36 INFO - Running pre-action listener: _resource_record_pre_action 05:02:36 INFO - Running main action method: install 05:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:36 INFO - Reading from file tmpfile_stdout 05:02:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:02:37 INFO - Reading from file tmpfile_stdout 05:02:37 INFO - Output received: 05:02:37 INFO - Usage: mozinstall [options] installer 05:02:37 INFO - Options: 05:02:37 INFO - -h, --help show this help message and exit 05:02:37 INFO - -d DEST, --destination=DEST 05:02:37 INFO - Directory to install application into. [default: 05:02:37 INFO - "/builds/slave/test"] 05:02:37 INFO - --app=APP Application being installed. [default: firefox] 05:02:37 INFO - mkdir: /builds/slave/test/build/application 05:02:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 05:02:58 INFO - Reading from file tmpfile_stdout 05:02:58 INFO - Output received: 05:02:58 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:02:58 INFO - Running post-action listener: _resource_record_post_action 05:02:58 INFO - [mozharness: 2017-02-06 13:02:58.470384Z] Finished install step (success) 05:02:58 INFO - [mozharness: 2017-02-06 13:02:58.470517Z] Running run-tests step. 05:02:58 INFO - Running pre-action listener: _resource_record_pre_action 05:02:58 INFO - Running main action method: run_tests 05:02:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:02:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:02:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:02:58 INFO - 2017-02-06 05:02:58.485 screenresolution[1630:7694] starting screenresolution argv=screenresolution get 05:02:58 INFO - 2017-02-06 05:02:58.487 screenresolution[1630:7694] Display 0: 1600x1200x32@60 05:02:58 INFO - 2017-02-06 05:02:58.493 screenresolution[1631:7697] starting screenresolution argv=screenresolution list 05:02:58 INFO - Available Modes on Display 0 05:02:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:02:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:02:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:02:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:02:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:02:58 INFO - Intel Iris: 05:02:58 INFO - Chipset Model: Intel Iris 05:02:58 INFO - Type: GPU 05:02:58 INFO - Bus: Built-In 05:02:58 INFO - VRAM (Dynamic, Max): 1536 MB 05:02:58 INFO - Vendor: Intel (0x8086) 05:02:58 INFO - Device ID: 0x0a2e 05:02:58 INFO - Revision ID: 0x0009 05:02:58 INFO - Displays: 05:02:58 INFO - Display: 05:02:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:02:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:02:58 INFO - Display Serial Number: 1600x1200 60 05:02:58 INFO - Main Display: Yes 05:02:58 INFO - Mirror: Off 05:02:58 INFO - Online: Yes 05:02:58 INFO - Rotation: Supported 05:02:58 INFO - Return code: 0 05:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:02:58 INFO - Python 2.7.3 05:02:58 INFO - Return code: 0 05:02:58 INFO - grabbing minidump binary from tooltool 05:02:58 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')]} 05:02:58 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 0x1059f9d30>, '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 0x10585fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059f1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:02:58 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 05:02:58 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 05:02:58 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 05:02:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:58 INFO - Return code: 0 05:02:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:02:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:02:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:02:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:02:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:02:58 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/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0262', '--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 05:02:58 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/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0262 --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 05:02:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gMHOsXPdlV/Render', 05:02:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:58 INFO - 'HOME': '/Users/cltbld', 05:02:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:58 INFO - 'LOGNAME': 'cltbld', 05:02:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:02:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:58 INFO - 'MOZ_NO_REMOTE': '1', 05:02:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:02:58 INFO - 'NO_EM_RESTART': '1', 05:02:58 INFO - 'PAGER': '/bin/cat', 05:02:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:58 INFO - 'PWD': '/builds/slave/test', 05:02:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:02:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:58 INFO - 'SHELL': '/bin/bash', 05:02:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nrki7cVLJF/Listeners', 05:02:58 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 05:02:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:58 INFO - 'USER': 'cltbld', 05:02:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:58 INFO - 'XPC_FLAGS': '0x0', 05:02:58 INFO - 'XPC_SERVICE_NAME': '0', 05:02:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:58 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/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0262', '--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 05:02:59 INFO - mozversion application_buildid: 20170206020150 05:02:59 INFO - mozversion application_changeset: 06eda6a9a51fa6a6d2d2e38b178d4bf009891a77 05:02:59 INFO - mozversion application_display_name: Firefox 05:02:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:59 INFO - mozversion application_name: Firefox 05:02:59 INFO - mozversion application_remotingname: firefox 05:02:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:02:59 INFO - mozversion application_vendor: Mozilla 05:02:59 INFO - mozversion application_version: 52.0 05:02:59 INFO - mozversion platform_buildid: 20170206020150 05:02:59 INFO - mozversion platform_changeset: 06eda6a9a51fa6a6d2d2e38b178d4bf009891a77 05:02:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:02:59 INFO - mozversion platform_version: 52.0 05:02:59 INFO - using testdate: 1486386179 05:02:59 INFO - actual date: 1486386179 05:02:59 INFO - starting webserver on 'localhost:49243' 05:02:59 INFO - SUITE-START | Running 2 tests 05:02:59 INFO - TEST-START | dromaeo_css 05:02:59 INFO - operating with platform_type : mac_ 05:02:59 INFO - Initialising browser for dromaeo_css test... 05:02:59 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpMQAhS_/profile http://localhost:49243/getInfo.html) 05:03:01 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 05:03:01 INFO - PROCESS | 1641 | colorDepth:24 05:03:01 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 05:03:01 INFO - PROCESS | 1641 | __metrics 05:03:01 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:03:01 INFO - PROCESS | 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:03:02 INFO - TEST-INFO | 1641: exit 0 05:03:02 INFO - Browser initialized. 05:03:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:03:02 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpMQAhS_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:14 INFO - PROCESS | 1644 | RSS: Main: 168218624 05:03:14 INFO - PROCESS | 1644 | 05:06:18 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 05:06:19 INFO - PROCESS | 1644 | RSS: Main: 270979072 05:06:19 INFO - PROCESS | 1644 | 05:09:22 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 05:09:22 INFO - PROCESS | 1644 | RSS: Main: 295940096 05:09:22 INFO - PROCESS | 1644 | 05:12:25 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 05:12:25 INFO - PROCESS | 1644 | RSS: Main: 273063936 05:12:25 INFO - PROCESS | 1644 | 05:15:27 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 05:15:28 INFO - PROCESS | 1644 | RSS: Main: 284037120 05:15:28 INFO - PROCESS | 1644 | 05:18:31 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 05:18:32 INFO - PROCESS | 1644 | RSS: Main: 262283264 05:18:32 INFO - PROCESS | 1644 | 05:21:35 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 05:21:35 INFO - PROCESS | 1644 | RSS: Main: 350724096 05:21:35 INFO - PROCESS | 1644 | 05:21:35 INFO - PROCESS | 1644 | __start_tp_report 05:21:35 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 05:21:35 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 05:21:35 INFO - PROCESS | 1644 | |i|pagename|runs| 05:21:35 INFO - PROCESS | 1644 | |0;dojo.html;3430.142464383904;3470.340635279296;3475.669811367919;3503.3518799022168;3536.7524273300864;5698.316202055754;5742.196092547047;5746.540276777858;5764.135379693038;5766.538676905842;5014.623903207255;5644.238027866237;5798.884022319551;5815.098659707742;5821.7380217890195;5195.798465396938;5222.3472065991755;5259.2899958505495;5278.3138192034985;5285.841424757264;5170.689758614476;5173.9741301293625;5194.480551944813;5338.599605029619;5339.492748188935;4804.759762011903;4862.756862156878;5207.088759467097;5242.764075616587;5255.763490642911;5219.973900130494;5258.0009798138235;5282.568122433744;5292.311999440049;5294.973525132388;5157.69053856766;5204.245384419238;5246.685198888079;5262.684238945675;5291.074062039166;5630.8029218977135;5668.291463567054;5689.772409103631;5699.572532060112;5726.055200891848;6144.433169541739;6211.81364559064;6235.719392627343;6237.469815065725;6242.969909964851;6327.715252813635;6328.557001009931;6344.143540622049;6345.682715864188;6349.873002539969;5729.627574207663;5769.85575360611;5773.913391299134;5808.854778630568;5865.266841644794;6282.654454005074;6306.590071645328;6318.62088274705;6322.462590679844;6340.365963403623;6136.8772624547255;6171.9691401543605;6174.876502470015;6177.351378105324;6184.536159788034;6151.384861513902;6188.257409110935;6194.566380353332;6203.31763506014;6286.277078136073;6221.720022598994;6254.437100660963;6258.311585725566;6262;6271.4669253114;6212.596181248205;6292.402221788922;6295.685215739286;6299.6535190564955;6318.368163183645;4842.104210721028;4905.386826646669;4908.877278068006;4921.064997650435;4983.451820299764;4180.28935081037;4470.821167153343;4497.325401189848;4525;4538.841140560065;5782.017057100303;5790.276215473066;5793.768249270066;5807.506361959281;5823.941760582425;6144.849302744004;6281.183446151971;6303.684815759194;6326.715297811517;6331.2085989251345;5610.4670056344585;5685.005124103348;5717.142428635738;5734.913976290359;5801.477866991907;5292.153255479182;5400.729963501888;5401.378841433207;5408.594355423359;5408.702521361363;6324.557280990471;6333.65164915934;6334.1765570475545;6367.872642547123;6408.327125651833;6134.773364742599;6135.477655820289;6137.407629318989;6244.344343843831;6290;6329.367063293634;6331.9366806331345;6338.239411270492;6342.048692695948;6343.492520598434;6241.407066328691;6253.593516421418;6258.468030217483;6263.154474145932;6265.8120256392385;6112.1387513176505;6180.351063138306;6205.875882482415;6207.34822843613;6299.275583307978;6121.483458747687;6165.815025549241;6180.721867515883;6187.597806142587;6195.070739389128;6095.238095238095;6114.969425152845;6117.113018612187;6124.356942520971;6129.693515324127;5547.195656629847;5666.829995100154;5829.650220986754;5910.143029260647;6026.939730602638;6110.69446527663;6172.166757487682;6180.6909654517995;6190.566660333733;6192.164057852132;6012.746743386829;6054.152418661479;6065.6663883486835;6117.969410153099;6120.265568131853 05:21:35 INFO - PROCESS | 1644 | |1;ext.html;460.9697326475329;518.7354449230892;519.2133917115568;522.3235909497199;528.886289447769;31337.216569585773;33015.33969320615;39822.40266396003;40966.59033409665;41261.58738412615;42802.57197428025;43003.92490187747;43105;43176.568234317725;43265;8690.522021288842;9749.268804839665;9764.804703905918;9777.31558790885;9786.90213097867;9542.952285238563;9633.229341652686;9642.035796420338;9647.710568682916;9649.565769540352;9592.944776074626;9645.95177024114;9660.565274562627;9664.130228279453;9665.806683866318;9567.569459374345;9621.13409793115;9630.711078667651;9639.903600964006;9645.951770241174;9587.952060239653;9622.855657165148;9633.08485693858;9648.98685638005;9667;40102.39846402306;40484;40486;40531.39202911959;40552.18895622071;3240.238543942172;3339;3443.6900678938764;3462.0652423845672;3813.3707938190164;29637.110886673436;29656.110316690534;29929.700702993126;31541.053768386984;32084.839575802205;3151.7636177286795;3267.313864088544;3279.8524066417067;3282.1302354875975;3300.273939733255;526324;528270.3586482081;528608;529045;529406;33975.32049359049;62150.68924655348;62638.747225056155;62688.74622507524;62695;34972.300553989284;35555;35929.82035089808;35977.64022359743;35995.100122496624;15098.622534436507;15252.0086194397;15259.389624415122;15282.617934551503;15307.387704491919;12851.807222891664;12948.676283092998;12949.676258093623;12966.286854223108;12981.805272920914;7974.840503189904;7983.20167983197;7983.321417679563;8057.234562716532;8100.473469224482;3320.833958302075;3351.5307856900054;3358.3954888120375;3366.3435630052395;3406.5571475707998;916.3081873185702;953.7377221264069;966.5747071288611;1063.5533076108054;1068.5832525314977;29413.705862941526;29535.759970932166;29616.407671846442;29863.81906533087;30081.398372032876;826.3141592478229;845.3786466946789;982.9187893317294;1087.472575800736;1120.4789772755707;11213.887861121448;15668.529944101696;15981.200939952956;16212.432564860173;16435;682506;730809;732422;734036;965840;59287.51781205418;59911.700441497516;59941.70029149914;59963.40036599578;60113.699431502566;1173.530587764901;1259.458432873873;1302.9869701302866;1387.049870838479;1413.6075965174296;25933.870330648228;25959.480810384066;30498.542521861746;31106.22234444157;32083.83958080288;55171.62070948259;55185.89628207494;55816;56389;56552.15171772509;630122;631878;632689;634402;634716;27021.729782702707;27343.179704608894;27821.721782782723;27902.30244243829;28475.715242847305;46793.064138716356;46860.53139468562;47219;47239.52760472351;47317.76341118272;37351.813240933625;38152.809235953646;40244.39633405443;40794.38808417936;41801;36639.816800915825;37854;38382.42426363551;39602;39635.405468917415;31803.840980794947;33512.32975340528;33635.99092027243;39029.414558782206;39284.6071539281;31901.521477178325;34044.489332659534;34860.82569587136;34864.30271394608;34880.82559587288;25916.35209119787;26052;26052.95788168452;26428.735712643396;26587.601185982614 05:21:35 INFO - PROCESS | 1644 | |2;jquery.html;339.6857906436546;388.1325238092864;398.2234642447228;402.86906755304494;415.8399016378695;18582.442526724204;20322.59354812903;21007.789922100776;21257.787422125773;21297.893510532445;20096.698549521734;20403.489912752153;20591.691124633104;20682.586348273024;20924.37226883192;4956.479569645189;5715.485606295432;5970.074638431029;6786.932130678704;6887.449004079662;6552.770653027145;6817.011533327664;6905.827354316132;6912.447004239649;6916.443800144977;6436.259830119526;6508.251551071617;6517.283098859121;6525.510586705992;6537.967310163466;6361.109444677726;6509.837254068662;6514.250861150981;6736.2590115087305;6847.109875716174;5940.049592065248;5941.851453713692;5942.910856337158;5943.791967281168;5957.731902064417;25230.747692523208;25269.49461010788;25284;25567.87216063908;25864.96540138392;2404.314770290459;2745.207333824369;3135.843207839599;3181.729552987999;3196.7762256642045;14289.571312860631;15848.128352940583;16080.758788618181;16375.83624163755;16486.917565412215;1867.8038805925319;1882.8587855910725;1902.7050807124917;1919.7600299962505;1933.5939452714947;116397.41801291025;117842.82157178404;120914;123321.38339308336;123986.38006809998;9521.095495927875;9851.655192068387;10171.23715721309;10189.796204075878;10348.741281467874;12571.93714031424;12658.303793291274;12662.810057848956;12674.683132921751;12681;7955.164707705723;8197;8234.300084492885;8246.958765206136;8315.875261871077;8555.914440855637;8564.015138259056;8567.186117318844;8699.782505437288;8722.694705685271;3392.609849867297;3876.2247550490015;3950.9802450988136;4023.8189281482405;4101.2207680540605;1664.4340924085868;1910.4459706685184;1971.7141014553097;1974.1412485568824;1975.1309423853459;389.18660000598317;410.6612045062835;411.31105398457464;826.4049884083571;904.9411788233743;11724.941375293069;11868.525258989544;11891.464884080237;11900.107491938139;12161.69595760113;435.27743945051697;435.75597665307527;450.0436572283897;451.525897807301;474.1418033359561;6117.235345581802;6185.41238582334;6190.895095667494;6253.593516421418;6319.462845658079;597464;601764;618086;619446;633084;84366.57816711;133301;136469;140724;141550.29224853808;437.21301657017875;450.40096671426926;452.3960512715496;453.1028563444333;454.0510333403203;10039.949800250952;11485.138614604106;11570.363630000431;11774.764504710029;11904.523819047141;42233.57766422296;47260.29109563428;47829.565113046665;51410;51825.740871295406;59132.70433647804;76100.61949690216;77746.6112669433;78550;78928;7297.963510182415;7498.437617178843;7645.235476452311;8015.519068855887;8271.710490132817;9178.816423671622;11347.865213478917;12252.387380631111;12508.312042837731;13551.254680992246;10565.9471702641;11371.090312774793;11414.372209528556;11461.484233209692;11463.140264480031;10075.841278253094;11252.26860254081;11393.202475826612;11625.302481851117;11745.647630571097;11471.598494052669;11599.710007249887;11674.474648640662;11980.64058078259;12040.337781422106;8192.221738934792;8233.876491852747;8588.22705956467;8692.043875173853;8720.91279087201;10203.38779673222;11586.478608462809;11613.825792612948;11924.986376158124;11929 05:21:35 INFO - PROCESS | 1644 | |3;mootools.html;1484.1391992644271;1527.85485378889;1631.1599526243995;1705.2923036939671;1879.0604697651183;8164.306033987111;8602.698905538307;8611.009733880606;8619.91380086199;8628.870566941501;6490.870182596345;7637.9236207637905;7799.376049916007;8398.49609023459;8428.578571071452;2365.136725095341;2389.2593296078185;2393.1265088242753;2395.197608801054;2396.2212281008656;2371.513839662865;2395.832291739579;2422.3701837522194;2425.3815277104313;2426.745191754858;1933.7679478462535;2361.669366288721;2379.6430535419654;2380.5119950410126;2383.392234980078;2345.906163753465;2353.752855950126;2377.9048838046456;2380.297812145421;2381.1546900850294;2375.3349062262596;2386.6539351794067;2397.137030668958;2401.147592604618;2401.5196960607773;8473.067962524117;8556.786080348042;8556.786080348042;8559;8567.186117318844;5115.309433226504;5282.920756188661;5286.629935904488;5288.127458969304;5295.126304159809;3088.1970687621156;3433.6223015468277;3493.6681015303507;3501.1422201560526;3569.01851990702;968.3899143539595;1079.3955384984433;1085.3433672628025;1108.7893300273004;1115.7712668902855;10901.073408760265;10996.670099897015;11009.339439633568;11016.06363459107;11036.061934735557;4537.931931021038;4701.506341834127;4821.349117869113;4826.855194344175;4826.8793280168275;9613.423194608346;9613.51932403377;9620.71137865865;9658.517074146264;9675.854862177073;5301.284326615934;5304;5307.177387504943;5308.124159513714;5314.388845282842;4373.6282415994365;4396.736195828261;4793.976030119827;4845.176320025604;4874.8537543873745;3838.596947320547;3867.61323867611;3923.92152156961;3968.1270120573427;3971.384435412516;1278.1564167649308;1288.6391810293132;1290.993545032269;1302.8176055352258;1303.4134639412302;878.3854438983536;881.4314766975265;886.2378354615026;890.3945317184248;900.2572877376191;5358.374396545664;5391.272178255964;5584.692841893735;5600.131979543177;5665.575081868794;440.83468699237784;451.90058187198764;460.57396907860095;463.9420072490939;465.9487456379795;3788.242351529705;3792.27946690128;3830.751001184914;3866.574676785551;3920.7259789322125;9760.804783904425;10325.32885362449;10339.896601033894;10359.32664376813;10372.222083343779;9871.753206169904;10027.999999999854;10053.195744340435;10253.897461025294;10284.897151028394;7815.882761758578;7879.133295337509;7918.2477664621765;7971.880421793678;7994.720184793504;5440.319960004999;5452.890942181213;5624.803131890364;5660.462256085665;5754.625949313281;9488.810223795623;9521.809563808547;9566.808663826545;9568.76078098053;9573.569189386355;9180.816383672423;9513;9521.809563808547;9639.987801280764;9666.468344240853;6716.29478904708;6900.206476255295;7083.185433675193;7168.928310716826;7333.156686981066;7805.882911756442;8079;8082.515049096838;8095.109537950703;8099.068607110022;6893.448524118159;7210.242924492853;7259.37279178327;7317.890231646423;7484.925150748423;7078.610676412847;7134;7144;7268.818279542842;7289.453291003302;6812.727490900308;6816.795496134925;6891.069705589882;6892.138482689664;6901.102856628606;4802.615790736802;4824.131656301899;4838.637102217418;4898.21628539432;4901.485344038967;4088.8568900089545;4786.44955830084;4796.592289655278;4927;4974.502549744997 05:21:35 INFO - PROCESS | 1644 | |4;prototype.html;310.5109452612136;315.3393640323523;318.3013285837586;323.6181306058851;324.87817068599276;5137.229415587654;5221.765020574074;5227.346581677295;5241.240020197074;5263.894722105556;4411.492678341991;4930.580900623451;4961.255811628258;5095.490450954902;5139.6659217150855;3336.215989242526;3659.3047321009058;3693.5198424204814;3940.8177546736006;4000.8599699010542;3148.7323577495827;3947.368421052632;3959.366501359783;3979.2041591681777;3982.780947047911;3422.640622734614;3689.4834723138783;3963.8612648557305;3964.682825373963;3985.5416627087966;3948.2695701295065;3962;3988.601139886003;3992.7205095643317;4003.6997225207933;2896.4062367214883;3072.892448764305;3143.6070491188602;3309.0072978106473;3431.4338134207824;4233.51314598822;4872.878178045542;5082.491750824925;5093.261477085802;5145.974270128625;4205.621494065549;4502.109114172055;4521.412216411878;4544.681872268942;4564.726116433025;4388.4733831940375;4798.968221832288;5472.398036216013;5494.598877286307;5583.664980101207;3195.5526226328334;3768.2840260350445;3785.728562862288;3796.2027974125467;3800.277947190025;5270.0461566127715;5650.717464126818;5672.432756724335;5734.655920644733;5754;3867.1105645701646;3971.265315916507;4006.9965017491254;4008.915364010698;4039.313316736162;3541.29174165168;3962.3660214365564;4065.6137666921595;4072.3484242521645;4078.469798926121;3958.287508248485;4294.377315289265;4556.681032327705;4660.161170989187;4674.649401294916;4597.816087356468;5352.223927530486;5438.102713052302;5500.477454641803;5509.917351239735;1307.718840449289;1315.4740501018773;1317.2491679742645;1324.324594456834;1326.4230059923964;866.5450638414883;879.4591326334386;907.8651685393259;926.7072433954596;929.2426672262085;4626.514216007271;4843.491433399513;4854.951450485521;4864.246041863516;4954.801807927714;4945.2582112683385;5249;5339.946600533945;5348.983693098299;5377.596680248997;3814.7901865397116;4422.668299877522;4807.927881081787;5279.86482906177;5343.545798607084;2352.9058837646303;2528.9114880979077;2550.495207827391;2770.6259654946325;2840.900568480093;5587.7485513152005;5616.494515493625;5633.267675202197;5667.506297229206;5673.177389278531;4636.44362676481;4691.62467002639;5370.570354371641;5492.011437941129;5574.498295153456;4905.130498658182;5074.985002999341;5108.029474399852;5258.316418865599;5366.465336790406;4474.977625111854;5131.332926719502;5213.739313034257;5381.905404392568;5464.945350546603;4774.856754297377;5136.871578210575;5246.842594722164;5347.973260133675;5381.246625472515;5029.667138208304;5180.093483640423;5377.435369286169;5598.412166722435;5617.943820561905;3364.108511244571;3378.087916262546;3422.4866270059692;3479.756417050782;3688.9077773055888;4322.724796185195;4886.703249472742;4912.557869791736;5027.561632608255;5301.178317360661;4611.354410382616;4744.315767902345;4861.927071093865;5174.197999310113;5218.556422704112;4159.8960025998385;4532.410786597721;4559.401141349399;5090.923636145387;5214.348206474191;4206.495220573551;4779.920734480512;5093.261477085728;5122.259591118734;5184.870378240424;5121.9243958769075;5325.387580428301;5370.409254981871;5404.108322126805;5488.423715509974;4592.908141837212;4602.79287432073;4649.697769644962;4666.853247506185;5471.835844924659 05:21:35 INFO - PROCESS | 1644 | |5;yui.html;719.0723966083752;756.9962150189248;764.1975925278456;797.1550156833756;819.3117781063905;14207.502737404193;15260;15347.84652153481;15367.308471118798;15375.846241537582;13842.515511957083;13996.440142394293;14002.509912153077;14014.649633759136;14032.859671403283;678.4267294136447;703.0684343245194;844.8986121665408;853.7737499562605;860.4880096342666;868.6568805321895;869.0223498564116;871.8430682477151;872.6116877989298;875.4090988582712;932.1936524905975;933.1927882381725;934.4253284230183;934.4673536084434;937.5546615357719;924.0620769918538;925.3291363761286;926.7358802741254;927.935044546882;929.6560272699145;690.8618276344752;691.0877641513205;691.6472598974509;692.6467501574233;693.4106009891602;13978.580642580739;14038.859611403857;14060.789088163685;14154.150750954976;14843.628909277246;13936.651583710387;14082.55083160959;14314.284285785669;14392.784108238386;14561.196379378202;11046.392448415334;11641.6507504775;11650.533978640844;11706.239094458919;11755.882441175565;3659.7255205859665;3677.17263615687;3696.6303369663087;3724.6461586149544;3762.059485128718;84675;91522;91818;91825.54087229588;92557;11057.281276716987;11114.666560003212;11115.777684446266;11136.721581960515;11173.385463799568;21358.466038348855;21369.252076177258;21451.03470343838;21624.02691878869;21664.675029874248;7041.049458323163;7699.307062364414;7736.883946740803;7914.485558438798;7957.084935232522;4340.9131817364105;4376.562343765598;4479.260921947842;4492.618127459203;4657.068586282757;3316.1709572606846;3455.6371580983637;3455.8617655293506;3455.87904423344;3458.2737625098507;642.7429028388589;646.5377255262509;690.4855882367668;726.1032624708481;727.8798998165349;616.5345164400849;640.7084776426715;674.9730010799611;689.396777819408;693.9271376505495;8767.342449316327;9371.765705857408;9537.666181683608;9560.426374417419;9697.757556061155;662.8863509304318;666.8132922781629;677.8000489855505;698.947578931572;705.5555000349747;3727.8881633551036;4610.884727881763;4630.6758526902795;4651.511591282867;4665.6967297125575;122712;125726;126063.369683151;126643;129657.35171324272;37074.44388334177;37409.25181496355;67620;111623.4418827917;113121.43439282915;91412.54293728489;93786;94667.57998629888;96427.77372425847;101466;7254.585355855557;7371.889421658787;8664.78338041554;8916.777080572778;9063.048379920278;59667;60116;60349.09476357946;60911;62232.44418889564;75014;75072;85515;89152;91239.06946048485;12362.938185309376;12419.379031048593;12596.244225346141;12691.301978391277;12714.61856144317;14207.431702731776;14725.969182157147;14945.925270374013;15195.488308664977;15203.467878624195;12885.033622478164;13110.475580977036;13238.205707657571;13351.866481335062;13660.043796934118;12562.371881406076;12788.936055320037;13010;13192.538261160813;13644.863551364358;13012.479500819862;13150.342482876009;13504.86495135036;13745.793813092612;14252.429902804186;10197.84703229467;10306.742331441474;10395.740106497398;11042.723931901766;11342;11364.886351136383;11381.715457113638;11395.202335836744;11556.42217889119;11645.359505226956 05:21:35 INFO - PROCESS | 1644 | __end_tp_report 05:21:35 INFO - PROCESS | 1644 | __start_cc_report 05:21:35 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1207 05:21:35 INFO - PROCESS | 1644 | __end_cc_report 05:21:35 INFO - PROCESS | 1644 | __startTimestamp1486387295874__endTimestamp 05:21:35 INFO - PROCESS | 1644 | 05:21:35 INFO - PROCESS | 1644 | ------- Summary: start ------- 05:21:35 INFO - PROCESS | 1644 | Number of tests: 6 05:21:35 INFO - PROCESS | 1644 | 05:21:35 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5768.24 Median:6065.67 stddev:639.83 (10.5%) stddev-sans-first:614.94 05:21:35 INFO - PROCESS | 1644 | Values: 3430.1 3470.3 3475.7 3503.4 3536.8 5698.3 5742.2 5746.5 5764.1 5766.5 5014.6 5644.2 5798.9 5815.1 5821.7 5195.8 5222.3 5259.3 5278.3 5285.8 5170.7 5174.0 5194.5 5338.6 5339.5 4804.8 4862.8 5207.1 5242.8 5255.8 5220.0 5258.0 5282.6 5292.3 5295.0 5157.7 5204.2 5246.7 5262.7 5291.1 5630.8 5668.3 5689.8 5699.6 5726.1 6144.4 6211.8 6235.7 6237.5 6243.0 6327.7 6328.6 6344.1 6345.7 6349.9 5729.6 5769.9 5773.9 5808.9 5865.3 6282.7 6306.6 6318.6 6322.5 6340.4 6136.9 6172.0 6174.9 6177.4 6184.5 6151.4 6188.3 6194.6 6203.3 6286.3 6221.7 6254.4 6258.3 6262.0 6271.5 6212.6 6292.4 6295.7 6299.7 6318.4 4842.1 4905.4 4908.9 4921.1 4983.5 4180.3 4470.8 4497.3 4525.0 4538.8 5782.0 5790.3 5793.8 5807.5 5823.9 6144.8 6281.2 6303.7 6326.7 6331.2 5610.5 5685.0 5717.1 5734.9 5801.5 5292.2 5400.7 5401.4 5408.6 5408.7 6324.6 6333.7 6334.2 6367.9 6408.3 6134.8 6135.5 6137.4 6244.3 6290.0 6329.4 6331.9 6338.2 6342.0 6343.5 6241.4 6253.6 6258.5 6263.2 6265.8 6112.1 6180.4 6205.9 6207.3 6299.3 6121.5 6165.8 6180.7 6187.6 6195.1 6095.2 6115.0 6117.1 6124.4 6129.7 5547.2 5666.8 5829.7 5910.1 6026.9 6110.7 6172.2 6180.7 6190.6 6192.2 6012.7 6054.2 6065.7 6118.0 6120.3 05:21:35 INFO - PROCESS | 1644 | 05:21:35 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:75290.75 Median:40173.40 stddev:175790.77 (437.6%) stddev-sans-first:176194.12 05:21:35 INFO - PROCESS | 1644 | Values: 461.0 518.7 519.2 522.3 528.9 31337.2 33015.3 39822.4 40966.6 41261.6 42802.6 43003.9 43105.0 43176.6 43265.0 8690.5 9749.3 9764.8 9777.3 9786.9 9543.0 9633.2 9642.0 9647.7 9649.6 9592.9 9646.0 9660.6 9664.1 9665.8 9567.6 9621.1 9630.7 9639.9 9646.0 9588.0 9622.9 9633.1 9649.0 9667.0 40102.4 40484.0 40486.0 40531.4 40552.2 3240.2 3339.0 3443.7 3462.1 3813.4 29637.1 29656.1 29929.7 31541.1 32084.8 3151.8 3267.3 3279.9 3282.1 3300.3 526324.0 528270.4 528608.0 529045.0 529406.0 33975.3 62150.7 62638.7 62688.7 62695.0 34972.3 35555.0 35929.8 35977.6 35995.1 15098.6 15252.0 15259.4 15282.6 15307.4 12851.8 12948.7 12949.7 12966.3 12981.8 7974.8 7983.2 7983.3 8057.2 8100.5 3320.8 3351.5 3358.4 3366.3 3406.6 916.3 953.7 966.6 1063.6 1068.6 29413.7 29535.8 29616.4 29863.8 30081.4 826.3 845.4 982.9 1087.5 1120.5 11213.9 15668.5 15981.2 16212.4 16435.0 682506.0 730809.0 732422.0 734036.0 965840.0 59287.5 59911.7 59941.7 59963.4 60113.7 1173.5 1259.5 1303.0 1387.0 1413.6 25933.9 25959.5 30498.5 31106.2 32083.8 55171.6 55185.9 55816.0 56389.0 56552.2 630122.0 631878.0 632689.0 634402.0 634716.0 27021.7 27343.2 27821.7 27902.3 28475.7 46793.1 46860.5 47219.0 47239.5 47317.8 37351.8 38152.8 40244.4 40794.4 41801.0 36639.8 37854.0 38382.4 39602.0 39635.4 31803.8 33512.3 33636.0 39029.4 39284.6 31901.5 34044.5 34860.8 34864.3 34880.8 25916.4 26052.0 26053.0 26428.7 26587.6 05:21:35 INFO - PROCESS | 1644 | 05:21:35 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:34813.33 Median:2170.08 stddev:102489.89 (4722.9%) stddev-sans-first:102744.71 05:21:35 INFO - PROCESS | 1644 | Values: 339.7 388.1 398.2 402.9 415.8 18582.4 20322.6 21007.8 21257.8 21297.9 20096.7 20403.5 20591.7 20682.6 20924.4 4956.5 5715.5 5970.1 6786.9 6887.4 6552.8 6817.0 6905.8 6912.4 6916.4 6436.3 6508.3 6517.3 6525.5 6538.0 6361.1 6509.8 6514.3 6736.3 6847.1 5940.0 5941.9 5942.9 5943.8 5957.7 25230.7 25269.5 25284.0 25567.9 25865.0 2404.3 2745.2 3135.8 3181.7 3196.8 14289.6 15848.1 16080.8 16375.8 16486.9 1867.8 1882.9 1902.7 1919.8 1933.6 116397.4 117842.8 120914.0 123321.4 123986.4 9521.1 9851.7 10171.2 10189.8 10348.7 12571.9 12658.3 12662.8 12674.7 12681.0 7955.2 8197.0 8234.3 8247.0 8315.9 8555.9 8564.0 8567.2 8699.8 8722.7 3392.6 3876.2 3951.0 4023.8 4101.2 1664.4 1910.4 1971.7 1974.1 1975.1 389.2 410.7 411.3 826.4 904.9 11724.9 11868.5 11891.5 11900.1 12161.7 435.3 435.8 450.0 451.5 474.1 6117.2 6185.4 6190.9 6253.6 6319.5 597464.0 601764.0 618086.0 619446.0 633084.0 84366.6 133301.0 136469.0 140724.0 141550.3 437.2 450.4 452.4 453.1 454.1 10039.9 11485.1 11570.4 11774.8 11904.5 42233.6 47260.3 47829.6 51410.0 51825.7 59132.7 76100.6 77746.6 78550.0 78928.0 7298.0 7498.4 7645.2 8015.5 8271.7 9178.8 11347.9 12252.4 12508.3 13551.3 10565.9 11371.1 11414.4 11461.5 11463.1 10075.8 11252.3 11393.2 11625.3 11745.6 11471.6 11599.7 11674.5 11980.6 12040.3 8192.2 8233.9 8588.2 8692.0 8720.9 10203.4 11586.5 11613.8 11925.0 11929.0 05:21:35 INFO - PROCESS | 1644 | 05:21:35 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5502.68 Median:4950.75 stddev:3035.98 (61.3%) stddev-sans-first:3029.47 05:21:35 INFO - PROCESS | 1644 | Values: 1484.1 1527.9 1631.2 1705.3 1879.1 8164.3 8602.7 8611.0 8619.9 8628.9 6490.9 7637.9 7799.4 8398.5 8428.6 2365.1 2389.3 2393.1 2395.2 2396.2 2371.5 2395.8 2422.4 2425.4 2426.7 1933.8 2361.7 2379.6 2380.5 2383.4 2345.9 2353.8 2377.9 2380.3 2381.2 2375.3 2386.7 2397.1 2401.1 2401.5 8473.1 8556.8 8556.8 8559.0 8567.2 5115.3 5282.9 5286.6 5288.1 5295.1 3088.2 3433.6 3493.7 3501.1 3569.0 968.4 1079.4 1085.3 1108.8 1115.8 10901.1 10996.7 11009.3 11016.1 11036.1 4537.9 4701.5 4821.3 4826.9 4826.9 9613.4 9613.5 9620.7 9658.5 9675.9 5301.3 5304.0 5307.2 5308.1 5314.4 4373.6 4396.7 4794.0 4845.2 4874.9 3838.6 3867.6 3923.9 3968.1 3971.4 1278.2 1288.6 1291.0 1302.8 1303.4 878.4 881.4 886.2 890.4 900.3 5358.4 5391.3 5584.7 5600.1 5665.6 440.8 451.9 460.6 463.9 465.9 3788.2 3792.3 3830.8 3866.6 3920.7 9760.8 10325.3 10339.9 10359.3 10372.2 9871.8 10028.0 10053.2 10253.9 10284.9 7815.9 7879.1 7918.2 7971.9 7994.7 5440.3 5452.9 5624.8 5660.5 5754.6 9488.8 9521.8 9566.8 9568.8 9573.6 9180.8 9513.0 9521.8 9640.0 9666.5 6716.3 6900.2 7083.2 7168.9 7333.2 7805.9 8079.0 8082.5 8095.1 8099.1 6893.4 7210.2 7259.4 7317.9 7484.9 7078.6 7134.0 7144.0 7268.8 7289.5 6812.7 6816.8 6891.1 6892.1 6901.1 4802.6 4824.1 4838.6 4898.2 4901.5 4088.9 4786.4 4796.6 4927.0 4974.5 05:21:35 INFO - PROCESS | 1644 | 05:21:35 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4294.45 Median:4759.59 stddev:1292.73 (27.2%) stddev-sans-first:1261.30 05:21:35 INFO - PROCESS | 1644 | Values: 310.5 315.3 318.3 323.6 324.9 5137.2 5221.8 5227.3 5241.2 5263.9 4411.5 4930.6 4961.3 5095.5 5139.7 3336.2 3659.3 3693.5 3940.8 4000.9 3148.7 3947.4 3959.4 3979.2 3982.8 3422.6 3689.5 3963.9 3964.7 3985.5 3948.3 3962.0 3988.6 3992.7 4003.7 2896.4 3072.9 3143.6 3309.0 3431.4 4233.5 4872.9 5082.5 5093.3 5146.0 4205.6 4502.1 4521.4 4544.7 4564.7 4388.5 4799.0 5472.4 5494.6 5583.7 3195.6 3768.3 3785.7 3796.2 3800.3 5270.0 5650.7 5672.4 5734.7 5754.0 3867.1 3971.3 4007.0 4008.9 4039.3 3541.3 3962.4 4065.6 4072.3 4078.5 3958.3 4294.4 4556.7 4660.2 4674.6 4597.8 5352.2 5438.1 5500.5 5509.9 1307.7 1315.5 1317.2 1324.3 1326.4 866.5 879.5 907.9 926.7 929.2 4626.5 4843.5 4855.0 4864.2 4954.8 4945.3 5249.0 5339.9 5349.0 5377.6 3814.8 4422.7 4807.9 5279.9 5343.5 2352.9 2528.9 2550.5 2770.6 2840.9 5587.7 5616.5 5633.3 5667.5 5673.2 4636.4 4691.6 5370.6 5492.0 5574.5 4905.1 5075.0 5108.0 5258.3 5366.5 4475.0 5131.3 5213.7 5381.9 5464.9 4774.9 5136.9 5246.8 5348.0 5381.2 5029.7 5180.1 5377.4 5598.4 5617.9 3364.1 3378.1 3422.5 3479.8 3688.9 4322.7 4886.7 4912.6 5027.6 5301.2 4611.4 4744.3 4861.9 5174.2 5218.6 4159.9 4532.4 4559.4 5090.9 5214.3 4206.5 4779.9 5093.3 5122.3 5184.9 5121.9 5325.4 5370.4 5404.1 5488.4 4592.9 4602.8 4649.7 4666.9 5471.8 05:21:35 INFO - PROCESS | 1644 | 05:21:35 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:21358.25 Median:4051.49 stddev:32145.96 (793.4%) stddev-sans-first:32198.78 05:21:35 INFO - PROCESS | 1644 | Values: 719.1 757.0 764.2 797.2 819.3 14207.5 15260.0 15347.8 15367.3 15375.8 13842.5 13996.4 14002.5 14014.6 14032.9 678.4 703.1 844.9 853.8 860.5 868.7 869.0 871.8 872.6 875.4 932.2 933.2 934.4 934.5 937.6 924.1 925.3 926.7 927.9 929.7 690.9 691.1 691.6 692.6 693.4 13978.6 14038.9 14060.8 14154.2 14843.6 13936.7 14082.6 14314.3 14392.8 14561.2 11046.4 11641.7 11650.5 11706.2 11755.9 3659.7 3677.2 3696.6 3724.6 3762.1 84675.0 91522.0 91818.0 91825.5 92557.0 11057.3 11114.7 11115.8 11136.7 11173.4 21358.5 21369.3 21451.0 21624.0 21664.7 7041.0 7699.3 7736.9 7914.5 7957.1 4340.9 4376.6 4479.3 4492.6 4657.1 3316.2 3455.6 3455.9 3455.9 3458.3 642.7 646.5 690.5 726.1 727.9 616.5 640.7 675.0 689.4 693.9 8767.3 9371.8 9537.7 9560.4 9697.8 662.9 666.8 677.8 698.9 705.6 3727.9 4610.9 4630.7 4651.5 4665.7 122712.0 125726.0 126063.4 126643.0 129657.4 37074.4 37409.3 67620.0 111623.4 113121.4 91412.5 93786.0 94667.6 96427.8 101466.0 7254.6 7371.9 8664.8 8916.8 9063.0 59667.0 60116.0 60349.1 60911.0 62232.4 75014.0 75072.0 85515.0 89152.0 91239.1 12362.9 12419.4 12596.2 12691.3 12714.6 14207.4 14726.0 14945.9 15195.5 15203.5 12885.0 13110.5 13238.2 13351.9 13660.0 12562.4 12788.9 13010.0 13192.5 13644.9 13012.5 13150.3 13504.9 13745.8 14252.4 10197.8 10306.7 10395.7 11042.7 11342.0 11364.9 11381.7 11395.2 11556.4 11645.4 05:21:35 INFO - PROCESS | 1644 | -------- Summary: end -------- 05:21:35 INFO - PROCESS | 1644 | 05:21:36 INFO - TEST-INFO | 1644: exit 0 05:21:36 INFO - TEST-OK | dromaeo_css | took 1117396ms 05:21:36 INFO - TEST-START | kraken 05:21:36 INFO - operating with platform_type : mac_ 05:21:36 INFO - Initialising browser for kraken test... 05:21:36 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmp90SGCI/profile http://localhost:49243/getInfo.html) 05:21:38 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 05:21:38 INFO - PROCESS | 1650 | colorDepth:24 05:21:38 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 05:21:38 INFO - PROCESS | 1650 | __metrics 05:21:39 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:21:39 INFO - PROCESS | 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:21:39 INFO - TEST-INFO | 1650: exit 0 05:21:39 INFO - Browser initialized. 05:21:39 INFO - Running cycle 1/1 for kraken test... 05:21:39 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmp90SGCI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:51 INFO - PROCESS | 1652 | RSS: Main: 172191744 05:21:51 INFO - PROCESS | 1652 | 05:21:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 05:21:55 INFO - PROCESS | 1652 | RSS: Main: 221876224 05:21:55 INFO - PROCESS | 1652 | 05:21:58 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 05:21:58 INFO - PROCESS | 1652 | RSS: Main: 233754624 05:21:58 INFO - PROCESS | 1652 | 05:22:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 05:22:02 INFO - PROCESS | 1652 | RSS: Main: 330534912 05:22:02 INFO - PROCESS | 1652 | 05:22:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 05:22:04 INFO - PROCESS | 1652 | RSS: Main: 230866944 05:22:04 INFO - PROCESS | 1652 | 05:22:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:22:07 INFO - PROCESS | 1652 | RSS: Main: 233017344 05:22:07 INFO - PROCESS | 1652 | 05:22:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 05:22:11 INFO - PROCESS | 1652 | RSS: Main: 274329600 05:22:11 INFO - PROCESS | 1652 | 05:22:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 05:22:14 INFO - PROCESS | 1652 | RSS: Main: 274243584 05:22:14 INFO - PROCESS | 1652 | 05:22:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 05:22:17 INFO - PROCESS | 1652 | RSS: Main: 269807616 05:22:17 INFO - PROCESS | 1652 | 05:22:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:22:20 INFO - PROCESS | 1652 | RSS: Main: 247099392 05:22:20 INFO - PROCESS | 1652 | 05:22:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:22:22 INFO - PROCESS | 1652 | RSS: Main: 251424768 05:22:22 INFO - PROCESS | 1652 | 05:22:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:22:25 INFO - PROCESS | 1652 | RSS: Main: 254316544 05:22:25 INFO - PROCESS | 1652 | 05:22:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:22:28 INFO - PROCESS | 1652 | RSS: Main: 266317824 05:22:28 INFO - PROCESS | 1652 | 05:22:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:22:32 INFO - PROCESS | 1652 | RSS: Main: 266313728 05:22:32 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 05:22:34 INFO - PROCESS | 1652 | RSS: Main: 309903360 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | __start_tp_report 05:22:34 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 05:22:34 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 05:22:34 INFO - PROCESS | 1652 | |i|pagename|runs| 05:22:34 INFO - PROCESS | 1652 | |0;ai-astar;114;113;114;113;120;161;113;112;112;113 05:22:34 INFO - PROCESS | 1652 | |1;audio-beat-detection;140;109;109;139;100;107;110;107;135;107 05:22:34 INFO - PROCESS | 1652 | |2;audio-dft;183;183;182;183;182;183;181;181;183;182 05:22:34 INFO - PROCESS | 1652 | |3;audio-fft;80;59;59;87;60;60;59;57;81;60 05:22:34 INFO - PROCESS | 1652 | |4;audio-oscillator;87;69;94;71;84;98;121;83;68;91 05:22:34 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;87;83;86;84;86;84;87;84;88;128 05:22:34 INFO - PROCESS | 1652 | |6;imaging-darkroom;93;94;94;102;93;93;93;93;93;92 05:22:34 INFO - PROCESS | 1652 | |7;imaging-desaturate;82;82;83;101;125;123;84;83;84;81 05:22:34 INFO - PROCESS | 1652 | |8;json-parse-financial;55;54;54;54;56;56;56;56;56;56 05:22:34 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;63;70;64;76;69;69;68;69;69;71 05:22:34 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;83;83;84;82;82;82;80;84;86;83 05:22:34 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;124;125;143;142;137;138;141;140;188;161 05:22:34 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;160;162;158;160;168;180;164;159;207;191 05:22:34 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;65;66;68;82;79;57;74;83;80;79 05:22:34 INFO - PROCESS | 1652 | __end_tp_report 05:22:34 INFO - PROCESS | 1652 | __start_cc_report 05:22:34 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1919 05:22:34 INFO - PROCESS | 1652 | __end_cc_report 05:22:34 INFO - PROCESS | 1652 | __startTimestamp1486387354435__endTimestamp 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | ------- Summary: start ------- 05:22:34 INFO - PROCESS | 1652 | Number of tests: 14 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:118.50 Median:113.50 stddev:15.11 (13.3%) stddev-sans-first:15.94 05:22:34 INFO - PROCESS | 1652 | Values: 114.0 113.0 114.0 113.0 120.0 161.0 113.0 112.0 112.0 113.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:116.30 Median:109.50 stddev:15.27 (13.9%) stddev-sans-first:13.57 05:22:34 INFO - PROCESS | 1652 | Values: 140.0 109.0 109.0 139.0 100.0 107.0 110.0 107.0 135.0 107.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:182.30 Median:183.00 stddev:0.82 (0.4%) stddev-sans-first:0.83 05:22:34 INFO - PROCESS | 1652 | Values: 183.0 183.0 182.0 183.0 182.0 183.0 181.0 181.0 183.0 182.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.00 stddev:11.54 (19.2%) stddev-sans-first:11.10 05:22:34 INFO - PROCESS | 1652 | Values: 80.0 59.0 59.0 87.0 60.0 60.0 59.0 57.0 81.0 60.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:86.60 Median:85.50 stddev:16.01 (18.7%) stddev-sans-first:16.98 05:22:34 INFO - PROCESS | 1652 | Values: 87.0 69.0 94.0 71.0 84.0 98.0 121.0 83.0 68.0 91.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:89.70 Median:86.00 stddev:13.56 (15.8%) stddev-sans-first:14.34 05:22:34 INFO - PROCESS | 1652 | Values: 87.0 83.0 86.0 84.0 86.0 84.0 87.0 84.0 88.0 128.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:93.00 stddev:2.87 (3.1%) stddev-sans-first:3.02 05:22:34 INFO - PROCESS | 1652 | Values: 93.0 94.0 94.0 102.0 93.0 93.0 93.0 93.0 93.0 92.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:92.80 Median:82.50 stddev:17.43 (21.1%) stddev-sans-first:18.05 05:22:34 INFO - PROCESS | 1652 | Values: 82.0 82.0 83.0 101.0 125.0 123.0 84.0 83.0 84.0 81.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:0.95 (1.7%) stddev-sans-first:1.00 05:22:34 INFO - PROCESS | 1652 | Values: 55.0 54.0 54.0 54.0 56.0 56.0 56.0 56.0 56.0 56.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:3.58 (5.2%) stddev-sans-first:3.13 05:22:34 INFO - PROCESS | 1652 | Values: 63.0 70.0 64.0 76.0 69.0 69.0 68.0 69.0 69.0 71.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.60 (1.9%) stddev-sans-first:1.69 05:22:34 INFO - PROCESS | 1652 | Values: 83.0 83.0 84.0 82.0 82.0 82.0 80.0 84.0 86.0 83.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:141.50 stddev:18.56 (13.1%) stddev-sans-first:18.24 05:22:34 INFO - PROCESS | 1652 | Values: 124.0 125.0 143.0 142.0 137.0 138.0 141.0 140.0 188.0 161.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:166.00 stddev:16.57 (10.0%) stddev-sans-first:17.10 05:22:34 INFO - PROCESS | 1652 | Values: 160.0 162.0 158.0 160.0 168.0 180.0 164.0 159.0 207.0 191.0 05:22:34 INFO - PROCESS | 1652 | 05:22:34 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:79.00 stddev:8.79 (11.1%) stddev-sans-first:8.80 05:22:34 INFO - PROCESS | 1652 | Values: 65.0 66.0 68.0 82.0 79.0 57.0 74.0 83.0 80.0 79.0 05:22:34 INFO - PROCESS | 1652 | -------- Summary: end -------- 05:22:34 INFO - PROCESS | 1652 | 05:22:35 INFO - TEST-INFO | 1652: exit 0 05:22:35 INFO - TEST-OK | kraken | took 59151ms 05:22:35 INFO - SUITE-END | took 1176s 05:22:36 INFO - Completed test suite (00:19:37) 05:22:36 INFO - javascript benchmark 05:22:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3430.142464383904, 3470.340635279296, 3475.669811367919, 3503.3518799022168, 3536.7524273300864, 5698.316202055754, 5742.196092547047, 5746.540276777858, 5764.135379693038, 5766.538676905842, 5014.623903207255, 5644.238027866237, 5798.884022319551, 5815.098659707742, 5821.7380217890195, 5195.798465396938, 5222.3472065991755, 5259.2899958505495, 5278.3138192034985, 5285.841424757264, 5170.689758614476, 5173.9741301293625, 5194.480551944813, 5338.599605029619, 5339.492748188935, 4804.759762011903, 4862.756862156878, 5207.088759467097, 5242.764075616587, 5255.763490642911, 5219.973900130494, 5258.0009798138235, 5282.568122433744, 5292.311999440049, 5294.973525132388, 5157.69053856766, 5204.245384419238, 5246.685198888079, 5262.684238945675, 5291.074062039166, 5630.8029218977135, 5668.291463567054, 5689.772409103631, 5699.572532060112, 5726.055200891848, 6144.433169541739, 6211.81364559064, 6235.719392627343, 6237.469815065725, 6242.969909964851, 6327.715252813635, 6328.557001009931, 6344.143540622049, 6345.682715864188, 6349.873002539969, 5729.627574207663, 5769.85575360611, 5773.913391299134, 5808.854778630568, 5865.266841644794, 6282.654454005074, 6306.590071645328, 6318.62088274705, 6322.462590679844, 6340.365963403623, 6136.8772624547255, 6171.9691401543605, 6174.876502470015, 6177.351378105324, 6184.536159788034, 6151.384861513902, 6188.257409110935, 6194.566380353332, 6203.31763506014, 6286.277078136073, 6221.720022598994, 6254.437100660963, 6258.311585725566, 6262.0, 6271.4669253114, 6212.596181248205, 6292.402221788922, 6295.685215739286, 6299.6535190564955, 6318.368163183645, 4842.104210721028, 4905.386826646669, 4908.877278068006, 4921.064997650435, 4983.451820299764, 4180.28935081037, 4470.821167153343, 4497.325401189848, 4525.0, 4538.841140560065, 5782.017057100303, 5790.276215473066, 5793.768249270066, 5807.506361959281, 5823.941760582425, 6144.849302744004, 6281.183446151971, 6303.684815759194, 6326.715297811517, 6331.2085989251345, 5610.4670056344585, 5685.005124103348, 5717.142428635738, 5734.913976290359, 5801.477866991907, 5292.153255479182, 5400.729963501888, 5401.378841433207, 5408.594355423359, 5408.702521361363, 6324.557280990471, 6333.65164915934, 6334.1765570475545, 6367.872642547123, 6408.327125651833, 6134.773364742599, 6135.477655820289, 6137.407629318989, 6244.344343843831, 6290.0, 6329.367063293634, 6331.9366806331345, 6338.239411270492, 6342.048692695948, 6343.492520598434, 6241.407066328691, 6253.593516421418, 6258.468030217483, 6263.154474145932, 6265.8120256392385, 6112.1387513176505, 6180.351063138306, 6205.875882482415, 6207.34822843613, 6299.275583307978, 6121.483458747687, 6165.815025549241, 6180.721867515883, 6187.597806142587, 6195.070739389128, 6095.238095238095, 6114.969425152845, 6117.113018612187, 6124.356942520971, 6129.693515324127, 5547.195656629847, 5666.829995100154, 5829.650220986754, 5910.143029260647, 6026.939730602638, 6110.69446527663, 6172.166757487682, 6180.6909654517995, 6190.566660333733, 6192.164057852132, 6012.746743386829, 6054.152418661479, 6065.6663883486835, 6117.969410153099, 6120.265568131853], "value": 5727.64551616152, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.9697326475329, 518.7354449230892, 519.2133917115568, 522.3235909497199, 528.886289447769, 31337.216569585773, 33015.33969320615, 39822.40266396003, 40966.59033409665, 41261.58738412615, 42802.57197428025, 43003.92490187747, 43105.0, 43176.568234317725, 43265.0, 8690.522021288842, 9749.268804839665, 9764.804703905918, 9777.31558790885, 9786.90213097867, 9542.952285238563, 9633.229341652686, 9642.035796420338, 9647.710568682916, 9649.565769540352, 9592.944776074626, 9645.95177024114, 9660.565274562627, 9664.130228279453, 9665.806683866318, 9567.569459374345, 9621.13409793115, 9630.711078667651, 9639.903600964006, 9645.951770241174, 9587.952060239653, 9622.855657165148, 9633.08485693858, 9648.98685638005, 9667.0, 40102.39846402306, 40484.0, 40486.0, 40531.39202911959, 40552.18895622071, 3240.238543942172, 3339.0, 3443.6900678938764, 3462.0652423845672, 3813.3707938190164, 29637.110886673436, 29656.110316690534, 29929.700702993126, 31541.053768386984, 32084.839575802205, 3151.7636177286795, 3267.313864088544, 3279.8524066417067, 3282.1302354875975, 3300.273939733255, 526324.0, 528270.3586482081, 528608.0, 529045.0, 529406.0, 33975.32049359049, 62150.68924655348, 62638.747225056155, 62688.74622507524, 62695.0, 34972.300553989284, 35555.0, 35929.82035089808, 35977.64022359743, 35995.100122496624, 15098.622534436507, 15252.0086194397, 15259.389624415122, 15282.617934551503, 15307.387704491919, 12851.807222891664, 12948.676283092998, 12949.676258093623, 12966.286854223108, 12981.805272920914, 7974.840503189904, 7983.20167983197, 7983.321417679563, 8057.234562716532, 8100.473469224482, 3320.833958302075, 3351.5307856900054, 3358.3954888120375, 3366.3435630052395, 3406.5571475707998, 916.3081873185702, 953.7377221264069, 966.5747071288611, 1063.5533076108054, 1068.5832525314977, 29413.705862941526, 29535.759970932166, 29616.407671846442, 29863.81906533087, 30081.398372032876, 826.3141592478229, 845.3786466946789, 982.9187893317294, 1087.472575800736, 1120.4789772755707, 11213.887861121448, 15668.529944101696, 15981.200939952956, 16212.432564860173, 16435.0, 682506.0, 730809.0, 732422.0, 734036.0, 965840.0, 59287.51781205418, 59911.700441497516, 59941.70029149914, 59963.40036599578, 60113.699431502566, 1173.530587764901, 1259.458432873873, 1302.9869701302866, 1387.049870838479, 1413.6075965174296, 25933.870330648228, 25959.480810384066, 30498.542521861746, 31106.22234444157, 32083.83958080288, 55171.62070948259, 55185.89628207494, 55816.0, 56389.0, 56552.15171772509, 630122.0, 631878.0, 632689.0, 634402.0, 634716.0, 27021.729782702707, 27343.179704608894, 27821.721782782723, 27902.30244243829, 28475.715242847305, 46793.064138716356, 46860.53139468562, 47219.0, 47239.52760472351, 47317.76341118272, 37351.813240933625, 38152.809235953646, 40244.39633405443, 40794.38808417936, 41801.0, 36639.816800915825, 37854.0, 38382.42426363551, 39602.0, 39635.405468917415, 31803.840980794947, 33512.32975340528, 33635.99092027243, 39029.414558782206, 39284.6071539281, 31901.521477178325, 34044.489332659534, 34860.82569587136, 34864.30271394608, 34880.82559587288, 25916.35209119787, 26052.0, 26052.95788168452, 26428.735712643396, 26587.601185982614], "value": 18906.068848816398, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.6857906436546, 388.1325238092864, 398.2234642447228, 402.86906755304494, 415.8399016378695, 18582.442526724204, 20322.59354812903, 21007.789922100776, 21257.787422125773, 21297.893510532445, 20096.698549521734, 20403.489912752153, 20591.691124633104, 20682.586348273024, 20924.37226883192, 4956.479569645189, 5715.485606295432, 5970.074638431029, 6786.932130678704, 6887.449004079662, 6552.770653027145, 6817.011533327664, 6905.827354316132, 6912.447004239649, 6916.443800144977, 6436.259830119526, 6508.251551071617, 6517.283098859121, 6525.510586705992, 6537.967310163466, 6361.109444677726, 6509.837254068662, 6514.250861150981, 6736.2590115087305, 6847.109875716174, 5940.049592065248, 5941.851453713692, 5942.910856337158, 5943.791967281168, 5957.731902064417, 25230.747692523208, 25269.49461010788, 25284.0, 25567.87216063908, 25864.96540138392, 2404.314770290459, 2745.207333824369, 3135.843207839599, 3181.729552987999, 3196.7762256642045, 14289.571312860631, 15848.128352940583, 16080.758788618181, 16375.83624163755, 16486.917565412215, 1867.8038805925319, 1882.8587855910725, 1902.7050807124917, 1919.7600299962505, 1933.5939452714947, 116397.41801291025, 117842.82157178404, 120914.0, 123321.38339308336, 123986.38006809998, 9521.095495927875, 9851.655192068387, 10171.23715721309, 10189.796204075878, 10348.741281467874, 12571.93714031424, 12658.303793291274, 12662.810057848956, 12674.683132921751, 12681.0, 7955.164707705723, 8197.0, 8234.300084492885, 8246.958765206136, 8315.875261871077, 8555.914440855637, 8564.015138259056, 8567.186117318844, 8699.782505437288, 8722.694705685271, 3392.609849867297, 3876.2247550490015, 3950.9802450988136, 4023.8189281482405, 4101.2207680540605, 1664.4340924085868, 1910.4459706685184, 1971.7141014553097, 1974.1412485568824, 1975.1309423853459, 389.18660000598317, 410.6612045062835, 411.31105398457464, 826.4049884083571, 904.9411788233743, 11724.941375293069, 11868.525258989544, 11891.464884080237, 11900.107491938139, 12161.69595760113, 435.27743945051697, 435.75597665307527, 450.0436572283897, 451.525897807301, 474.1418033359561, 6117.235345581802, 6185.41238582334, 6190.895095667494, 6253.593516421418, 6319.462845658079, 597464.0, 601764.0, 618086.0, 619446.0, 633084.0, 84366.57816711, 133301.0, 136469.0, 140724.0, 141550.29224853808, 437.21301657017875, 450.40096671426926, 452.3960512715496, 453.1028563444333, 454.0510333403203, 10039.949800250952, 11485.138614604106, 11570.363630000431, 11774.764504710029, 11904.523819047141, 42233.57766422296, 47260.29109563428, 47829.565113046665, 51410.0, 51825.740871295406, 59132.70433647804, 76100.61949690216, 77746.6112669433, 78550.0, 78928.0, 7297.963510182415, 7498.437617178843, 7645.235476452311, 8015.519068855887, 8271.710490132817, 9178.816423671622, 11347.865213478917, 12252.387380631111, 12508.312042837731, 13551.254680992246, 10565.9471702641, 11371.090312774793, 11414.372209528556, 11461.484233209692, 11463.140264480031, 10075.841278253094, 11252.26860254081, 11393.202475826612, 11625.302481851117, 11745.647630571097, 11471.598494052669, 11599.710007249887, 11674.474648640662, 11980.64058078259, 12040.337781422106, 8192.221738934792, 8233.876491852747, 8588.22705956467, 8692.043875173853, 8720.91279087201, 10203.38779673222, 11586.478608462809, 11613.825792612948, 11924.986376158124, 11929.0], "value": 8829.614127521907, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.1391992644271, 1527.85485378889, 1631.1599526243995, 1705.2923036939671, 1879.0604697651183, 8164.306033987111, 8602.698905538307, 8611.009733880606, 8619.91380086199, 8628.870566941501, 6490.870182596345, 7637.9236207637905, 7799.376049916007, 8398.49609023459, 8428.578571071452, 2365.136725095341, 2389.2593296078185, 2393.1265088242753, 2395.197608801054, 2396.2212281008656, 2371.513839662865, 2395.832291739579, 2422.3701837522194, 2425.3815277104313, 2426.745191754858, 1933.7679478462535, 2361.669366288721, 2379.6430535419654, 2380.5119950410126, 2383.392234980078, 2345.906163753465, 2353.752855950126, 2377.9048838046456, 2380.297812145421, 2381.1546900850294, 2375.3349062262596, 2386.6539351794067, 2397.137030668958, 2401.147592604618, 2401.5196960607773, 8473.067962524117, 8556.786080348042, 8556.786080348042, 8559.0, 8567.186117318844, 5115.309433226504, 5282.920756188661, 5286.629935904488, 5288.127458969304, 5295.126304159809, 3088.1970687621156, 3433.6223015468277, 3493.6681015303507, 3501.1422201560526, 3569.01851990702, 968.3899143539595, 1079.3955384984433, 1085.3433672628025, 1108.7893300273004, 1115.7712668902855, 10901.073408760265, 10996.670099897015, 11009.339439633568, 11016.06363459107, 11036.061934735557, 4537.931931021038, 4701.506341834127, 4821.349117869113, 4826.855194344175, 4826.8793280168275, 9613.423194608346, 9613.51932403377, 9620.71137865865, 9658.517074146264, 9675.854862177073, 5301.284326615934, 5304.0, 5307.177387504943, 5308.124159513714, 5314.388845282842, 4373.6282415994365, 4396.736195828261, 4793.976030119827, 4845.176320025604, 4874.8537543873745, 3838.596947320547, 3867.61323867611, 3923.92152156961, 3968.1270120573427, 3971.384435412516, 1278.1564167649308, 1288.6391810293132, 1290.993545032269, 1302.8176055352258, 1303.4134639412302, 878.3854438983536, 881.4314766975265, 886.2378354615026, 890.3945317184248, 900.2572877376191, 5358.374396545664, 5391.272178255964, 5584.692841893735, 5600.131979543177, 5665.575081868794, 440.83468699237784, 451.90058187198764, 460.57396907860095, 463.9420072490939, 465.9487456379795, 3788.242351529705, 3792.27946690128, 3830.751001184914, 3866.574676785551, 3920.7259789322125, 9760.804783904425, 10325.32885362449, 10339.896601033894, 10359.32664376813, 10372.222083343779, 9871.753206169904, 10027.999999999854, 10053.195744340435, 10253.897461025294, 10284.897151028394, 7815.882761758578, 7879.133295337509, 7918.2477664621765, 7971.880421793678, 7994.720184793504, 5440.319960004999, 5452.890942181213, 5624.803131890364, 5660.462256085665, 5754.625949313281, 9488.810223795623, 9521.809563808547, 9566.808663826545, 9568.76078098053, 9573.569189386355, 9180.816383672423, 9513.0, 9521.809563808547, 9639.987801280764, 9666.468344240853, 6716.29478904708, 6900.206476255295, 7083.185433675193, 7168.928310716826, 7333.156686981066, 7805.882911756442, 8079.0, 8082.515049096838, 8095.109537950703, 8099.068607110022, 6893.448524118159, 7210.242924492853, 7259.37279178327, 7317.890231646423, 7484.925150748423, 7078.610676412847, 7134.0, 7144.0, 7268.818279542842, 7289.453291003302, 6812.727490900308, 6816.795496134925, 6891.069705589882, 6892.138482689664, 6901.102856628606, 4802.615790736802, 4824.131656301899, 4838.637102217418, 4898.21628539432, 4901.485344038967, 4088.8568900089545, 4786.44955830084, 4796.592289655278, 4927.0, 4974.502549744997], "value": 4393.0444125197155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.5109452612136, 315.3393640323523, 318.3013285837586, 323.6181306058851, 324.87817068599276, 5137.229415587654, 5221.765020574074, 5227.346581677295, 5241.240020197074, 5263.894722105556, 4411.492678341991, 4930.580900623451, 4961.255811628258, 5095.490450954902, 5139.6659217150855, 3336.215989242526, 3659.3047321009058, 3693.5198424204814, 3940.8177546736006, 4000.8599699010542, 3148.7323577495827, 3947.368421052632, 3959.366501359783, 3979.2041591681777, 3982.780947047911, 3422.640622734614, 3689.4834723138783, 3963.8612648557305, 3964.682825373963, 3985.5416627087966, 3948.2695701295065, 3962.0, 3988.601139886003, 3992.7205095643317, 4003.6997225207933, 2896.4062367214883, 3072.892448764305, 3143.6070491188602, 3309.0072978106473, 3431.4338134207824, 4233.51314598822, 4872.878178045542, 5082.491750824925, 5093.261477085802, 5145.974270128625, 4205.621494065549, 4502.109114172055, 4521.412216411878, 4544.681872268942, 4564.726116433025, 4388.4733831940375, 4798.968221832288, 5472.398036216013, 5494.598877286307, 5583.664980101207, 3195.5526226328334, 3768.2840260350445, 3785.728562862288, 3796.2027974125467, 3800.277947190025, 5270.0461566127715, 5650.717464126818, 5672.432756724335, 5734.655920644733, 5754.0, 3867.1105645701646, 3971.265315916507, 4006.9965017491254, 4008.915364010698, 4039.313316736162, 3541.29174165168, 3962.3660214365564, 4065.6137666921595, 4072.3484242521645, 4078.469798926121, 3958.287508248485, 4294.377315289265, 4556.681032327705, 4660.161170989187, 4674.649401294916, 4597.816087356468, 5352.223927530486, 5438.102713052302, 5500.477454641803, 5509.917351239735, 1307.718840449289, 1315.4740501018773, 1317.2491679742645, 1324.324594456834, 1326.4230059923964, 866.5450638414883, 879.4591326334386, 907.8651685393259, 926.7072433954596, 929.2426672262085, 4626.514216007271, 4843.491433399513, 4854.951450485521, 4864.246041863516, 4954.801807927714, 4945.2582112683385, 5249.0, 5339.946600533945, 5348.983693098299, 5377.596680248997, 3814.7901865397116, 4422.668299877522, 4807.927881081787, 5279.86482906177, 5343.545798607084, 2352.9058837646303, 2528.9114880979077, 2550.495207827391, 2770.6259654946325, 2840.900568480093, 5587.7485513152005, 5616.494515493625, 5633.267675202197, 5667.506297229206, 5673.177389278531, 4636.44362676481, 4691.62467002639, 5370.570354371641, 5492.011437941129, 5574.498295153456, 4905.130498658182, 5074.985002999341, 5108.029474399852, 5258.316418865599, 5366.465336790406, 4474.977625111854, 5131.332926719502, 5213.739313034257, 5381.905404392568, 5464.945350546603, 4774.856754297377, 5136.871578210575, 5246.842594722164, 5347.973260133675, 5381.246625472515, 5029.667138208304, 5180.093483640423, 5377.435369286169, 5598.412166722435, 5617.943820561905, 3364.108511244571, 3378.087916262546, 3422.4866270059692, 3479.756417050782, 3688.9077773055888, 4322.724796185195, 4886.703249472742, 4912.557869791736, 5027.561632608255, 5301.178317360661, 4611.354410382616, 4744.315767902345, 4861.927071093865, 5174.197999310113, 5218.556422704112, 4159.8960025998385, 4532.410786597721, 4559.401141349399, 5090.923636145387, 5214.348206474191, 4206.495220573551, 4779.920734480512, 5093.261477085728, 5122.259591118734, 5184.870378240424, 5121.9243958769075, 5325.387580428301, 5370.409254981871, 5404.108322126805, 5488.423715509974, 4592.908141837212, 4602.79287432073, 4649.697769644962, 4666.853247506185, 5471.835844924659], "value": 3896.7321030474195, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.0723966083752, 756.9962150189248, 764.1975925278456, 797.1550156833756, 819.3117781063905, 14207.502737404193, 15260.0, 15347.84652153481, 15367.308471118798, 15375.846241537582, 13842.515511957083, 13996.440142394293, 14002.509912153077, 14014.649633759136, 14032.859671403283, 678.4267294136447, 703.0684343245194, 844.8986121665408, 853.7737499562605, 860.4880096342666, 868.6568805321895, 869.0223498564116, 871.8430682477151, 872.6116877989298, 875.4090988582712, 932.1936524905975, 933.1927882381725, 934.4253284230183, 934.4673536084434, 937.5546615357719, 924.0620769918538, 925.3291363761286, 926.7358802741254, 927.935044546882, 929.6560272699145, 690.8618276344752, 691.0877641513205, 691.6472598974509, 692.6467501574233, 693.4106009891602, 13978.580642580739, 14038.859611403857, 14060.789088163685, 14154.150750954976, 14843.628909277246, 13936.651583710387, 14082.55083160959, 14314.284285785669, 14392.784108238386, 14561.196379378202, 11046.392448415334, 11641.6507504775, 11650.533978640844, 11706.239094458919, 11755.882441175565, 3659.7255205859665, 3677.17263615687, 3696.6303369663087, 3724.6461586149544, 3762.059485128718, 84675.0, 91522.0, 91818.0, 91825.54087229588, 92557.0, 11057.281276716987, 11114.666560003212, 11115.777684446266, 11136.721581960515, 11173.385463799568, 21358.466038348855, 21369.252076177258, 21451.03470343838, 21624.02691878869, 21664.675029874248, 7041.049458323163, 7699.307062364414, 7736.883946740803, 7914.485558438798, 7957.084935232522, 4340.9131817364105, 4376.562343765598, 4479.260921947842, 4492.618127459203, 4657.068586282757, 3316.1709572606846, 3455.6371580983637, 3455.8617655293506, 3455.87904423344, 3458.2737625098507, 642.7429028388589, 646.5377255262509, 690.4855882367668, 726.1032624708481, 727.8798998165349, 616.5345164400849, 640.7084776426715, 674.9730010799611, 689.396777819408, 693.9271376505495, 8767.342449316327, 9371.765705857408, 9537.666181683608, 9560.426374417419, 9697.757556061155, 662.8863509304318, 666.8132922781629, 677.8000489855505, 698.947578931572, 705.5555000349747, 3727.8881633551036, 4610.884727881763, 4630.6758526902795, 4651.511591282867, 4665.6967297125575, 122712.0, 125726.0, 126063.369683151, 126643.0, 129657.35171324272, 37074.44388334177, 37409.25181496355, 67620.0, 111623.4418827917, 113121.43439282915, 91412.54293728489, 93786.0, 94667.57998629888, 96427.77372425847, 101466.0, 7254.585355855557, 7371.889421658787, 8664.78338041554, 8916.777080572778, 9063.048379920278, 59667.0, 60116.0, 60349.09476357946, 60911.0, 62232.44418889564, 75014.0, 75072.0, 85515.0, 89152.0, 91239.06946048485, 12362.938185309376, 12419.379031048593, 12596.244225346141, 12691.301978391277, 12714.61856144317, 14207.431702731776, 14725.969182157147, 14945.925270374013, 15195.488308664977, 15203.467878624195, 12885.033622478164, 13110.475580977036, 13238.205707657571, 13351.866481335062, 13660.043796934118, 12562.371881406076, 12788.936055320037, 13010.0, 13192.538261160813, 13644.863551364358, 13012.479500819862, 13150.342482876009, 13504.86495135036, 13745.793813092612, 14252.429902804186, 10197.84703229467, 10306.742331441474, 10395.740106497398, 11042.723931901766, 11342.0, 11364.886351136383, 11381.715457113638, 11395.202335836744, 11556.42217889119, 11645.359505226956], "value": 7537.963022418421, "unit": "score"}], "name": "dromaeo_css", "value": 7055.822341620745, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 120.0, 161.0, 113.0, 112.0, 112.0, 113.0], "value": 118.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 109.0, 139.0, 100.0, 107.0, 110.0, 107.0, 135.0, 107.0], "value": 116.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 182.0, 183.0, 182.0, 183.0, 181.0, 181.0, 183.0, 182.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 87.0, 60.0, 60.0, 59.0, 57.0, 81.0, 60.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 94.0, 71.0, 84.0, 98.0, 121.0, 83.0, 68.0, 91.0], "value": 86.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 84.0, 86.0, 84.0, 87.0, 84.0, 88.0, 128.0], "value": 89.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 102.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 101.0, 125.0, 123.0, 84.0, 83.0, 84.0, 81.0], "value": 92.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 64.0, 76.0, 69.0, 69.0, 68.0, 69.0, 69.0, 71.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 82.0, 82.0, 82.0, 80.0, 84.0, 86.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 143.0, 142.0, 137.0, 138.0, 141.0, 140.0, 188.0, 161.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 158.0, 160.0, 168.0, 180.0, 164.0, 159.0, 207.0, 191.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 68.0, 82.0, 79.0, 57.0, 74.0, 83.0, 80.0, 79.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1441.5, "alertThreshold": 2.0}]} 05:22:36 INFO - Return code: 0 05:22:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:22:36 INFO - # TBPL SUCCESS # 05:22:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:22:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:22:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:22:36 INFO - 2017-02-06 05:22:36.225 screenresolution[1656:9951] starting screenresolution argv=screenresolution get 05:22:36 INFO - 2017-02-06 05:22:36.227 screenresolution[1656:9951] Display 0: 1600x1200x32@60 05:22:36 INFO - 2017-02-06 05:22:36.233 screenresolution[1657:9954] starting screenresolution argv=screenresolution list 05:22:36 INFO - Available Modes on Display 0 05:22:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:22:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:22:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:22:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:22:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:22:36 INFO - Intel Iris: 05:22:36 INFO - Chipset Model: Intel Iris 05:22:36 INFO - Type: GPU 05:22:36 INFO - Bus: Built-In 05:22:36 INFO - VRAM (Dynamic, Max): 1536 MB 05:22:36 INFO - Vendor: Intel (0x8086) 05:22:36 INFO - Device ID: 0x0a2e 05:22:36 INFO - Revision ID: 0x0009 05:22:36 INFO - Displays: 05:22:36 INFO - Display: 05:22:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:22:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:22:36 INFO - Display Serial Number: 1600x1200 60 05:22:36 INFO - Main Display: Yes 05:22:36 INFO - Mirror: Off 05:22:36 INFO - Online: Yes 05:22:36 INFO - Rotation: Supported 05:22:36 INFO - Return code: 0 05:22:36 INFO - Running post-action listener: _resource_record_post_action 05:22:36 INFO - [mozharness: 2017-02-06 13:22:36.468356Z] Finished run-tests step (success) 05:22:36 INFO - Running post-run listener: _resource_record_post_run 05:22:36 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 32582656; Write bytes: 499377664; Read time: 197; Write time: 1566 05:22:36 INFO - TinderboxPrint: CPU usage
53.6% 05:22:36 INFO - TinderboxPrint: I/O read bytes / time
32,582,656 / 197 05:22:36 INFO - TinderboxPrint: I/O write bytes / time
499,377,664 / 1,566 05:22:36 INFO - TinderboxPrint: CPU idle
2,224.8 (46.4%) 05:22:36 INFO - TinderboxPrint: CPU system
961.4 (20.0%) 05:22:36 INFO - TinderboxPrint: CPU user
1,611.5 (33.6%) 05:22:36 INFO - TinderboxPrint: Swap in / out
219,844,608 / 0 05:22:36 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 181137920; Write bytes: 177403904; Read time: 16494; Write time: 389 05:22:36 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31652864; Write bytes: 304782848; Read time: 186; Write time: 1123 05:22:36 INFO - Running post-run listener: _upload_blobber_files 05:22:36 INFO - Blob upload gear active. 05:22:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:22:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:22:36 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'] 05:22:36 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 05:22:37 INFO - (blobuploader) - INFO - Open directory for files ... 05:22:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:22:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:22:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:38 INFO - (blobuploader) - INFO - Done attempting. 05:22:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:22:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:22:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:39 INFO - (blobuploader) - INFO - Done attempting. 05:22:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:22:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:22:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:41 INFO - (blobuploader) - INFO - Done attempting. 05:22:41 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:41 INFO - Return code: 0 05:22:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:22:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0196211c5fd93c20cfa82de67dc13fbbe56eaeed2cd678d36919112cc992320a6dd53def903c18e3b2f58ad5aadb1af86a4583f0eceef39a9787cfc7c8ac379a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3442e08b700eb6d8ac324df33d384454596696b5a54abe879ec6671cee3897b9a7e18765221eb4e00a278a120e68b4a3422b33ea0b2d90212c678ac8392bd97b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a0d379f79c386c524558421f8475ffe9c4260d8b052beb64eff9ebeffc52f16784a5475ac1f9479812e8ea5edb803a8c4372a8e7ca52e00a5a20675b1180dd6"} 05:22:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:22:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:22:41 INFO - Contents: 05:22:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0196211c5fd93c20cfa82de67dc13fbbe56eaeed2cd678d36919112cc992320a6dd53def903c18e3b2f58ad5aadb1af86a4583f0eceef39a9787cfc7c8ac379a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3442e08b700eb6d8ac324df33d384454596696b5a54abe879ec6671cee3897b9a7e18765221eb4e00a278a120e68b4a3422b33ea0b2d90212c678ac8392bd97b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a0d379f79c386c524558421f8475ffe9c4260d8b052beb64eff9ebeffc52f16784a5475ac1f9479812e8ea5edb803a8c4372a8e7ca52e00a5a20675b1180dd6"} 05:22:41 INFO - Running post-run listener: copy_logs_to_upload_dir 05:22:41 INFO - Copying logs to upload dir... 05:22:41 INFO - mkdir: /builds/slave/test/build/upload/logs 05:22:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.417475 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-06 05:22:41.821086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 05:22:41.824654) ========= 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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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/0196211c5fd93c20cfa82de67dc13fbbe56eaeed2cd678d36919112cc992320a6dd53def903c18e3b2f58ad5aadb1af86a4583f0eceef39a9787cfc7c8ac379a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3442e08b700eb6d8ac324df33d384454596696b5a54abe879ec6671cee3897b9a7e18765221eb4e00a278a120e68b4a3422b33ea0b2d90212c678ac8392bd97b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a0d379f79c386c524558421f8475ffe9c4260d8b052beb64eff9ebeffc52f16784a5475ac1f9479812e8ea5edb803a8c4372a8e7ca52e00a5a20675b1180dd6"} build_url:https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/UAql8-ZBSEq-dBpL96k1ug/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0196211c5fd93c20cfa82de67dc13fbbe56eaeed2cd678d36919112cc992320a6dd53def903c18e3b2f58ad5aadb1af86a4583f0eceef39a9787cfc7c8ac379a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3442e08b700eb6d8ac324df33d384454596696b5a54abe879ec6671cee3897b9a7e18765221eb4e00a278a120e68b4a3422b33ea0b2d90212c678ac8392bd97b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a0d379f79c386c524558421f8475ffe9c4260d8b052beb64eff9ebeffc52f16784a5475ac1f9479812e8ea5edb803a8c4372a8e7ca52e00a5a20675b1180dd6"}' ========= master_lag: 0.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 05:22:42.216034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 05:22:42.216606) ========= 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.gMHOsXPdlV/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.Nrki7cVLJF/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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.004804 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 05:22:42.266427) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 05:22:42.266799) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 05:22:42.267303) ========= ========= Total master_lag: 0.55 =========