builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0226 starttime: 1485190256.65 results: success (0) buildid: 20170123062146 builduid: ceca632246fc4e66960a229e4c0dedf7 revision: 76101b503191468724851ba294a3d1fe7d2df50f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 08:50:56.653928) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 08:50:56.654388) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 08:50:56.654683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 08:50:56.680838) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 08:50:56.681145) ========= 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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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-01-23 08:50:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 149M=0s 2017-01-23 08:50:56 (149 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130840 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 08:50:56.836039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 08:50:56.836379) ========= 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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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.025830 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 08:50:56.884986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 08:50:56.885338) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 76101b503191468724851ba294a3d1fe7d2df50f --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 76101b503191468724851ba294a3d1fe7d2df50f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8kNOlchaOC/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.Fe1oLN0jyY/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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-01-23 08:50:56,971 truncating revision to first 12 chars 2017-01-23 08:50:56,971 Setting DEBUG logging. 2017-01-23 08:50:56,971 attempt 1/10 2017-01-23 08:50:56,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/76101b503191?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 08:50:58,408 unpacking tar archive at: mozilla-beta-76101b503191/testing/mozharness/ program finished with exit code 0 elapsedTime=1.728866 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 08:50:58.638590) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 08:50:58.638925) ========= script_repo_revision: 76101b503191468724851ba294a3d1fe7d2df50f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 08:50:58.639327) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 08:50:58.639600) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 08:50:58.659444) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-23 08:50:58.659909) ========= /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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:50:58 INFO - MultiFileLogger online at 20170123 08:50:58 in /builds/slave/test 08:50:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:50:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:50:58 INFO - {'append_to_log': False, 08:50:58 INFO - 'base_work_dir': '/builds/slave/test', 08:50:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:50:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:50:58 INFO - 'branch': 'Mozilla-Beta', 08:50:58 INFO - 'buildbot_json_path': 'buildprops.json', 08:50:58 INFO - 'config_files': ('talos/mac_config.py',), 08:50:58 INFO - 'default_actions': ('clobber', 08:50:58 INFO - 'read-buildbot-config', 08:50:58 INFO - 'download-and-extract', 08:50:58 INFO - 'populate-webroot', 08:50:58 INFO - 'create-virtualenv', 08:50:58 INFO - 'install', 08:50:58 INFO - 'run-tests'), 08:50:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:50:58 INFO - 'download_minidump_stackwalk': True, 08:50:58 INFO - 'download_symbols': 'ondemand', 08:50:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:50:58 INFO - 'tooltool.py': '/tools/tooltool.py', 08:50:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:50:58 INFO - '/tools/misc-python/virtualenv.py')}, 08:50:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:50:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:50:58 INFO - 'installer_path': 'installer.exe', 08:50:58 INFO - 'log_level': 'info', 08:50:58 INFO - 'log_name': 'talos', 08:50:58 INFO - 'log_to_console': True, 08:50:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:50:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:50:58 INFO - 'opt_config_files': (), 08:50:58 INFO - 'pip_index': False, 08:50:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:58 INFO - 'cmd': ('bash', 08:50:58 INFO - '-c', 08:50:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:58 INFO - 'enabled': True, 08:50:58 INFO - 'halt_on_failure': False, 08:50:58 INFO - 'name': 'check_screen_resolution'},), 08:50:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:58 INFO - 'cmd': ('bash', 08:50:58 INFO - '-c', 08:50:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:58 INFO - 'enabled': True, 08:50:58 INFO - 'halt_on_failure': False, 08:50:58 INFO - 'name': 'check_screen_resolution'},), 08:50:58 INFO - 'run_cmd_checks_enabled': True, 08:50:58 INFO - 'sps_profile': False, 08:50:58 INFO - 'sps_profile_interval': 0, 08:50:58 INFO - 'suite': 'dromaeojs', 08:50:58 INFO - 'system_bits': '32', 08:50:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:50:58 INFO - 'title': 't-yosemite-r7-0226', 08:50:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:50:58 INFO - 'use_talos_json': True, 08:50:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:50:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:50:58 INFO - 'work_dir': 'build'} 08:50:58 INFO - [mozharness: 2017-01-23 16:50:58.854461Z] Running clobber step. 08:50:58 INFO - Running pre-action listener: _resource_record_pre_action 08:50:58 INFO - Running main action method: clobber 08:50:58 INFO - rmtree: /builds/slave/test/build 08:50:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:51:01 INFO - Running post-action listener: _resource_record_post_action 08:51:01 INFO - [mozharness: 2017-01-23 16:51:01.319815Z] Finished clobber step (success) 08:51:01 INFO - [mozharness: 2017-01-23 16:51:01.319942Z] Running read-buildbot-config step. 08:51:01 INFO - Running pre-action listener: _resource_record_pre_action 08:51:01 INFO - Running main action method: read_buildbot_config 08:51:01 INFO - Using buildbot properties: 08:51:01 INFO - { 08:51:01 INFO - "project": "", 08:51:01 INFO - "product": "firefox", 08:51:01 INFO - "script_repo_revision": "production", 08:51:01 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:51:01 INFO - "repository": "", 08:51:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:51:01 INFO - "buildid": "20170123062146", 08:51:01 INFO - "pgo_build": "False", 08:51:01 INFO - "basedir": "/builds/slave/test", 08:51:01 INFO - "buildnumber": 3, 08:51:01 INFO - "slavename": "t-yosemite-r7-0226", 08:51:01 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:51:01 INFO - "platform": "yosemite_r7", 08:51:01 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:51:01 INFO - "branch": "mozilla-beta", 08:51:01 INFO - "repo_path": "releases/mozilla-beta", 08:51:01 INFO - "revision": "76101b503191468724851ba294a3d1fe7d2df50f", 08:51:01 INFO - "stage_platform": "macosx64", 08:51:01 INFO - "builduid": "ceca632246fc4e66960a229e4c0dedf7", 08:51:01 INFO - "slavebuilddir": "test" 08:51:01 INFO - } 08:51:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 08:51:01 INFO - Running post-action listener: _resource_record_post_action 08:51:01 INFO - [mozharness: 2017-01-23 16:51:01.323184Z] Finished read-buildbot-config step (success) 08:51:01 INFO - [mozharness: 2017-01-23 16:51:01.323269Z] Running download-and-extract step. 08:51:01 INFO - Running pre-action listener: _resource_record_pre_action 08:51:01 INFO - Running main action method: download_and_extract 08:51:01 INFO - mkdir: /builds/slave/test/build/tests 08:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:01 INFO - trying https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 08:51:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/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 08:51:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/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 08:51:02 INFO - Downloaded 1165 bytes. 08:51:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:51:02 INFO - Using the following test package requirements: 08:51:02 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:51:02 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:02 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 08:51:02 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:02 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 08:51:02 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:51:02 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:02 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 08:51:02 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:51:02 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:02 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 08:51:02 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:02 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 08:51:02 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:02 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 08:51:02 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:51:02 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 08:51:02 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 08:51:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:51:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:51:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:51:03 INFO - Http code: 200 08:51:03 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 08:51:03 INFO - x-amz-cf-id: kAv1fiuUO68FeBvSGccriDM-kk7rW-Mi15L40Tpmmt4x_BokUA7RWQ== 08:51:03 INFO - x-amz-version-id: BTSHU50ONI9ywRdR_ENg6tXuhdQt1Jtj 08:51:03 INFO - Expected file size: 16086062 08:51:03 INFO - Obtained file size: 16086062 08:51:10 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 08:51:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:51:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:51:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:51:10 INFO - Http code: 200 08:51:10 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 08:51:10 INFO - x-amz-cf-id: qOpJxOVhPAvyGQ3d6HHmy8Mt8g86lOEyrLB7tSCj3AC59mpoksbuVA== 08:51:10 INFO - x-amz-version-id: BTSHU50ONI9ywRdR_ENg6tXuhdQt1Jtj 08:51:11 INFO - Expected file size: 16086062 08:51:11 INFO - Obtained file size: 16086062 08:51:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 08:51:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 08:51:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 08:51:17 INFO - Http code: 200 08:51:17 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 08:51:17 INFO - x-amz-cf-id: tI9lkid0grbNavV6K_cwWMjRtnITVAU-k9o0RKH6WaGpnPj-1K6EeQ== 08:51:17 INFO - x-amz-version-id: 4RywBpJCrkK_DPpLOAh4RIg_F_k66317 08:51:18 INFO - Expected file size: 14402992 08:51:18 INFO - Obtained file size: 14402992 08:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:18 INFO - trying https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:51:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 08:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/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 08:51:20 INFO - Downloaded 82108413 bytes. 08:51:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:51:20 INFO - mkdir: /builds/slave/test/properties 08:51:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:20 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:20 INFO - Contents: 08:51:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:51:21 INFO - Running post-action listener: _resource_record_post_action 08:51:21 INFO - Running post-action listener: set_extra_try_arguments 08:51:21 INFO - [mozharness: 2017-01-23 16:51:21.400741Z] Finished download-and-extract step (success) 08:51:21 INFO - [mozharness: 2017-01-23 16:51:21.400910Z] Running populate-webroot step. 08:51:21 INFO - Running pre-action listener: _resource_record_pre_action 08:51:21 INFO - Running main action method: populate_webroot 08:51:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:21 INFO - '--tppagecycles', 08:51:21 INFO - '7'], 08:51:21 INFO - 'tests': ['tsvgm']}}, 08:51:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:51:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:51:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:51:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:51:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:51:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:21 INFO - 'talos_options': ['--disable-e10s'], 08:51:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:21 INFO - 'talos_options': ['--disable-e10s'], 08:51:21 INFO - 'tests': ['damp', 'tps']}, 08:51:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:21 INFO - 'tests': ['damp', 'tps']}, 08:51:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:51:21 INFO - 'tests': ['dromaeo_dom']}, 08:51:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:51:21 INFO - 'tests': ['basic_compositor_video']}, 08:51:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:51:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:51:21 INFO - 'tests': ['a11yr', 08:51:21 INFO - 'ts_paint', 08:51:21 INFO - 'tpaint', 08:51:21 INFO - 'sessionrestore', 08:51:21 INFO - 'sessionrestore_no_auto_restore', 08:51:21 INFO - 'tabpaint']}, 08:51:21 INFO - 'other-e10s': {'tests': ['a11yr', 08:51:21 INFO - 'ts_paint', 08:51:21 INFO - 'tpaint', 08:51:21 INFO - 'sessionrestore', 08:51:21 INFO - 'sessionrestore_no_auto_restore', 08:51:21 INFO - 'tabpaint']}, 08:51:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:51:21 INFO - 'ts_paint', 08:51:21 INFO - 'tpaint', 08:51:21 INFO - 'sessionrestore', 08:51:21 INFO - 'sessionrestore_no_auto_restore', 08:51:21 INFO - 'tabpaint']}, 08:51:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:51:21 INFO - 'ts_paint', 08:51:21 INFO - 'tpaint', 08:51:21 INFO - 'sessionrestore', 08:51:21 INFO - 'sessionrestore_no_auto_restore', 08:51:21 INFO - 'tabpaint']}, 08:51:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:51:21 INFO - 'tests': ['a11yr', 08:51:21 INFO - 'ts_paint', 08:51:21 INFO - 'tpaint', 08:51:21 INFO - 'sessionrestore', 08:51:21 INFO - 'sessionrestore_no_auto_restore', 08:51:21 INFO - 'tabpaint']}, 08:51:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:51:21 INFO - 'tests': ['a11yr', 08:51:21 INFO - 'ts_paint', 08:51:21 INFO - 'tpaint', 08:51:21 INFO - 'sessionrestore', 08:51:21 INFO - 'sessionrestore_no_auto_restore', 08:51:21 INFO - 'tabpaint']}, 08:51:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:51:21 INFO - 'tests': ['tsvgx', 08:51:21 INFO - 'tsvgr_opacity', 08:51:21 INFO - 'tart', 08:51:21 INFO - 'tscrollx', 08:51:21 INFO - 'cart']}, 08:51:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:51:21 INFO - 'tsvgr_opacity', 08:51:21 INFO - 'tart', 08:51:21 INFO - 'tscrollx', 08:51:21 INFO - 'cart']}, 08:51:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:21 INFO - 'talos_options': ['--disable-e10s'], 08:51:21 INFO - 'tests': ['tp5o']}, 08:51:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:21 INFO - 'tests': ['tp5o']}, 08:51:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:21 INFO - 'talos_options': ['--disable-e10s', 08:51:21 INFO - '--xperf_path', 08:51:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:21 INFO - 'tests': ['tp5n']}, 08:51:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:21 INFO - 'talos_options': ['--xperf_path', 08:51:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:21 INFO - 'tests': ['tp5n']}}, 08:51:21 INFO - 'talos.zip': {'path': '', 08:51:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:21 INFO - Running post-action listener: _resource_record_post_action 08:51:21 INFO - [mozharness: 2017-01-23 16:51:21.420191Z] Finished populate-webroot step (success) 08:51:21 INFO - [mozharness: 2017-01-23 16:51:21.420296Z] Running create-virtualenv step. 08:51:21 INFO - Running pre-action listener: _resource_record_pre_action 08:51:21 INFO - Running main action method: create_virtualenv 08:51:21 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:51:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:21 INFO - Using real prefix '/tools/python27' 08:51:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:25 INFO - Installing pip.................done. 08:51:25 INFO - Return code: 0 08:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:51:25 INFO - Reading from file tmpfile_stdout 08:51:25 INFO - Output received: 08:51:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:51:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:25 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 0x10ae8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05bec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9fd30>, '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 0x10ab05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac97b20>, '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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8kNOlchaOC/Render', 08:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:25 INFO - 'HOME': '/Users/cltbld', 08:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:25 INFO - 'LOGNAME': 'cltbld', 08:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:25 INFO - 'MOZ_NO_REMOTE': '1', 08:51:25 INFO - 'NO_EM_RESTART': '1', 08:51:25 INFO - 'PAGER': '/bin/cat', 08:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:25 INFO - 'PWD': '/builds/slave/test', 08:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:25 INFO - 'SHELL': '/bin/bash', 08:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fe1oLN0jyY/Listeners', 08:51:25 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:25 INFO - 'USER': 'cltbld', 08:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:25 INFO - 'XPC_FLAGS': '0x0', 08:51:25 INFO - 'XPC_SERVICE_NAME': '0', 08:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:51:25 INFO - Cleaning up... 08:51:25 INFO - Return code: 0 08:51:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:25 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 0x10ae8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05bec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9fd30>, '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 0x10ab05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac97b20>, '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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8kNOlchaOC/Render', 08:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:25 INFO - 'HOME': '/Users/cltbld', 08:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:25 INFO - 'LOGNAME': 'cltbld', 08:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:25 INFO - 'MOZ_NO_REMOTE': '1', 08:51:25 INFO - 'NO_EM_RESTART': '1', 08:51:25 INFO - 'PAGER': '/bin/cat', 08:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:25 INFO - 'PWD': '/builds/slave/test', 08:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:25 INFO - 'SHELL': '/bin/bash', 08:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fe1oLN0jyY/Listeners', 08:51:25 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:25 INFO - 'USER': 'cltbld', 08:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:25 INFO - 'XPC_FLAGS': '0x0', 08:51:25 INFO - 'XPC_SERVICE_NAME': '0', 08:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:25 INFO - Downloading/unpacking psutil>=3.1.1 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:29 INFO - Installing collected packages: psutil 08:51:29 INFO - Running setup.py install for psutil 08:51:29 INFO - building 'psutil._psutil_osx' extension 08:51:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:51:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:51:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:51:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:51:30 INFO - building 'psutil._psutil_posix' extension 08:51:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:51:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:51:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:51:30 INFO - ^ 08:51:30 INFO - 1 warning generated. 08:51:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:51:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:30 INFO - Successfully installed psutil 08:51:30 INFO - Cleaning up... 08:51:30 INFO - Return code: 0 08:51:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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')]} 08:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:30 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 0x10ae8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05bec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9fd30>, '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 0x10ab05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac97b20>, '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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8kNOlchaOC/Render', 08:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:30 INFO - 'HOME': '/Users/cltbld', 08:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:30 INFO - 'LOGNAME': 'cltbld', 08:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:30 INFO - 'MOZ_NO_REMOTE': '1', 08:51:30 INFO - 'NO_EM_RESTART': '1', 08:51:30 INFO - 'PAGER': '/bin/cat', 08:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:30 INFO - 'PWD': '/builds/slave/test', 08:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:30 INFO - 'SHELL': '/bin/bash', 08:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fe1oLN0jyY/Listeners', 08:51:30 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:30 INFO - 'USER': 'cltbld', 08:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:30 INFO - 'XPC_FLAGS': '0x0', 08:51:30 INFO - 'XPC_SERVICE_NAME': '0', 08:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:51:33 INFO - Installing collected packages: mozsystemmonitor 08:51:33 INFO - Running setup.py install for mozsystemmonitor 08:51:33 INFO - Successfully installed mozsystemmonitor 08:51:33 INFO - Cleaning up... 08:51:33 INFO - Return code: 0 08:51:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:33 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 0x10ae8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05bec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9fd30>, '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 0x10ab05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac97b20>, '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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8kNOlchaOC/Render', 08:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:33 INFO - 'HOME': '/Users/cltbld', 08:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:33 INFO - 'LOGNAME': 'cltbld', 08:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:33 INFO - 'MOZ_NO_REMOTE': '1', 08:51:33 INFO - 'NO_EM_RESTART': '1', 08:51:33 INFO - 'PAGER': '/bin/cat', 08:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:33 INFO - 'PWD': '/builds/slave/test', 08:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:33 INFO - 'SHELL': '/bin/bash', 08:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fe1oLN0jyY/Listeners', 08:51:33 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:33 INFO - 'USER': 'cltbld', 08:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:33 INFO - 'XPC_FLAGS': '0x0', 08:51:33 INFO - 'XPC_SERVICE_NAME': '0', 08:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:34 INFO - Downloading/unpacking jsonschema==2.5.1 08:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:51:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:51:37 INFO - warning: no files found matching '*.txt' 08:51:37 INFO - no previously-included directories found matching 'build' 08:51:37 INFO - no previously-included directories found matching 'dist' 08:51:37 INFO - no previously-included directories found matching '.git*' 08:51:37 INFO - Installing collected packages: jsonschema, functools32 08:51:37 INFO - Running setup.py install for functools32 08:51:37 INFO - warning: no files found matching '*.txt' 08:51:37 INFO - no previously-included directories found matching 'build' 08:51:37 INFO - no previously-included directories found matching 'dist' 08:51:37 INFO - no previously-included directories found matching '.git*' 08:51:37 INFO - Successfully installed jsonschema functools32 08:51:37 INFO - Cleaning up... 08:51:37 INFO - Return code: 0 08:51:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:37 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 0x10ae8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05bec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9fd30>, '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 0x10ab05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac97b20>, '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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:51:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8kNOlchaOC/Render', 08:51:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:37 INFO - 'HOME': '/Users/cltbld', 08:51:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:37 INFO - 'LOGNAME': 'cltbld', 08:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:37 INFO - 'MOZ_NO_REMOTE': '1', 08:51:37 INFO - 'NO_EM_RESTART': '1', 08:51:37 INFO - 'PAGER': '/bin/cat', 08:51:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:37 INFO - 'PWD': '/builds/slave/test', 08:51:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:37 INFO - 'SHELL': '/bin/bash', 08:51:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fe1oLN0jyY/Listeners', 08:51:37 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:51:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:37 INFO - 'USER': 'cltbld', 08:51:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:37 INFO - 'XPC_FLAGS': '0x0', 08:51:37 INFO - 'XPC_SERVICE_NAME': '0', 08:51:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:51:37 INFO - Cleaning up... 08:51:37 INFO - Return code: 0 08:51:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:37 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 0x10ae8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05bec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9fd30>, '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 0x10ab05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac97b20>, '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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:51:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8kNOlchaOC/Render', 08:51:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:37 INFO - 'HOME': '/Users/cltbld', 08:51:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:37 INFO - 'LOGNAME': 'cltbld', 08:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:37 INFO - 'MOZ_NO_REMOTE': '1', 08:51:37 INFO - 'NO_EM_RESTART': '1', 08:51:37 INFO - 'PAGER': '/bin/cat', 08:51:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:37 INFO - 'PWD': '/builds/slave/test', 08:51:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:37 INFO - 'SHELL': '/bin/bash', 08:51:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fe1oLN0jyY/Listeners', 08:51:37 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:51:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:37 INFO - 'USER': 'cltbld', 08:51:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:37 INFO - 'XPC_FLAGS': '0x0', 08:51:37 INFO - 'XPC_SERVICE_NAME': '0', 08:51:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:51:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:51:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:41 INFO - Downloading docopt-0.6.1.tar.gz 08:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:51:42 INFO - Installing collected packages: blobuploader, requests, docopt 08:51:42 INFO - Running setup.py install for blobuploader 08:51:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:51:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:51:42 INFO - Running setup.py install for requests 08:51:42 INFO - Running setup.py install for docopt 08:51:42 INFO - Successfully installed blobuploader requests docopt 08:51:42 INFO - Cleaning up... 08:51:42 INFO - Return code: 0 08:51:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:42 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 0x10ae8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05bec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9fd30>, '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 0x10ab05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac97b20>, '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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8kNOlchaOC/Render', 08:51:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:42 INFO - 'HOME': '/Users/cltbld', 08:51:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:42 INFO - 'LOGNAME': 'cltbld', 08:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:42 INFO - 'MOZ_NO_REMOTE': '1', 08:51:42 INFO - 'NO_EM_RESTART': '1', 08:51:42 INFO - 'PAGER': '/bin/cat', 08:51:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:42 INFO - 'PWD': '/builds/slave/test', 08:51:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:42 INFO - 'SHELL': '/bin/bash', 08:51:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fe1oLN0jyY/Listeners', 08:51:42 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:51:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:42 INFO - 'USER': 'cltbld', 08:51:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:42 INFO - 'XPC_FLAGS': '0x0', 08:51:42 INFO - 'XPC_SERVICE_NAME': '0', 08:51:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:43 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-l7oOWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:43 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-sjXPrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:43 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-iedRmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:43 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-KTHh39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:43 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-ExtyJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:43 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-tO1t9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:43 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-NgIfki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:43 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-R_lN3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:44 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-oXnVbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:44 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-gFQQoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:44 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-XD52NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:44 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-7yD2M5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:44 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-lyNOwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:44 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-td8RxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:44 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-JfkQrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:44 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-gM9wP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:44 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-VZTqL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:51:45 INFO - Running setup.py install for manifestparser 08:51:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:51:45 INFO - Running setup.py install for mozcrash 08:51:45 INFO - Running setup.py install for mozdebug 08:51:45 INFO - Running setup.py install for mozdevice 08:51:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:51:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:51:45 INFO - Running setup.py install for mozfile 08:51:45 INFO - Running setup.py install for mozhttpd 08:51:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:51:45 INFO - Running setup.py install for mozinfo 08:51:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:51:46 INFO - Running setup.py install for mozInstall 08:51:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:51:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:51:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:51:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:51:46 INFO - Running setup.py install for mozleak 08:51:46 INFO - Running setup.py install for mozlog 08:51:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:51:46 INFO - Running setup.py install for moznetwork 08:51:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:51:46 INFO - Running setup.py install for mozprocess 08:51:46 INFO - Running setup.py install for mozprofile 08:51:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:51:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:51:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:51:46 INFO - Running setup.py install for mozrunner 08:51:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:51:47 INFO - Running setup.py install for mozscreenshot 08:51:47 INFO - Running setup.py install for moztest 08:51:47 INFO - Running setup.py install for mozversion 08:51:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:51:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:51:47 INFO - Cleaning up... 08:51:47 INFO - Return code: 0 08:51:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:47 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 0x10ae8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05bec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9fd30>, '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 0x10ab05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac97b20>, '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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8kNOlchaOC/Render', 08:51:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:47 INFO - 'HOME': '/Users/cltbld', 08:51:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:47 INFO - 'LOGNAME': 'cltbld', 08:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:47 INFO - 'MOZ_NO_REMOTE': '1', 08:51:47 INFO - 'NO_EM_RESTART': '1', 08:51:47 INFO - 'PAGER': '/bin/cat', 08:51:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:47 INFO - 'PWD': '/builds/slave/test', 08:51:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:47 INFO - 'SHELL': '/bin/bash', 08:51:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fe1oLN0jyY/Listeners', 08:51:47 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:51:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:47 INFO - 'USER': 'cltbld', 08:51:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:47 INFO - 'XPC_FLAGS': '0x0', 08:51:47 INFO - 'XPC_SERVICE_NAME': '0', 08:51:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:47 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-EcLHUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:47 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-QROwaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:48 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-6v1YPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:48 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Ytvk4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:48 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)) 08:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:48 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-DH5rlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:48 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-KQy6EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:48 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-DBhp2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:48 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-BrCy3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:48 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-_CH26R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:48 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-IAq6BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:48 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-JwA8vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:49 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-tRVtPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:49 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)) 08:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:49 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Dtq8cV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:49 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-sciDo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:49 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-iJ5Owc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:49 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-o_C9U5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:49 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Ge08xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:51:49 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)) 08:51:49 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)) 08:51:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:52 INFO - Downloading blessings-1.6.tar.gz 08:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:51:52 INFO - Installing collected packages: blessings 08:51:52 INFO - Running setup.py install for blessings 08:51:52 INFO - Successfully installed blessings 08:51:52 INFO - Cleaning up... 08:51:52 INFO - Return code: 0 08:51:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:51:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:52 INFO - Reading from file tmpfile_stdout 08:51:52 INFO - Current package versions: 08:51:52 INFO - blessings == 1.6 08:51:52 INFO - blobuploader == 1.2.4 08:51:52 INFO - docopt == 0.6.1 08:51:52 INFO - functools32 == 3.2.3-2 08:51:52 INFO - jsonschema == 2.5.1 08:51:52 INFO - manifestparser == 1.1 08:51:52 INFO - mozInstall == 1.12 08:51:52 INFO - mozcrash == 1.0 08:51:52 INFO - mozdebug == 0.1 08:51:52 INFO - mozdevice == 0.48 08:51:52 INFO - mozfile == 1.2 08:51:52 INFO - mozhttpd == 0.7 08:51:52 INFO - mozinfo == 0.9 08:51:52 INFO - mozleak == 0.1 08:51:52 INFO - mozlog == 3.4 08:51:52 INFO - moznetwork == 0.27 08:51:52 INFO - mozprocess == 0.23 08:51:52 INFO - mozprofile == 0.28 08:51:52 INFO - mozrunner == 6.13 08:51:52 INFO - mozscreenshot == 0.1 08:51:52 INFO - mozsystemmonitor == 0.3 08:51:52 INFO - moztest == 0.8 08:51:52 INFO - mozversion == 1.4 08:51:52 INFO - psutil == 3.1.1 08:51:52 INFO - requests == 1.2.3 08:51:52 INFO - wsgiref == 0.1.2 08:51:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:53 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 0x10ae8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05bec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9fd30>, '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 0x10ab05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac97b20>, '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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8kNOlchaOC/Render', 08:51:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:53 INFO - 'HOME': '/Users/cltbld', 08:51:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:53 INFO - 'LOGNAME': 'cltbld', 08:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:53 INFO - 'MOZ_NO_REMOTE': '1', 08:51:53 INFO - 'NO_EM_RESTART': '1', 08:51:53 INFO - 'PAGER': '/bin/cat', 08:51:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:53 INFO - 'PWD': '/builds/slave/test', 08:51:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:53 INFO - 'SHELL': '/bin/bash', 08:51:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fe1oLN0jyY/Listeners', 08:51:53 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:51:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:53 INFO - 'USER': 'cltbld', 08:51:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:53 INFO - 'XPC_FLAGS': '0x0', 08:51:53 INFO - 'XPC_SERVICE_NAME': '0', 08:51:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:51:53 INFO - Cleaning up... 08:51:53 INFO - Return code: 0 08:51:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ae8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05bec50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9fd30>, '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 0x10ab05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac97b20>, '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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:51:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8kNOlchaOC/Render', 08:51:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:54 INFO - 'HOME': '/Users/cltbld', 08:51:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:54 INFO - 'LOGNAME': 'cltbld', 08:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:54 INFO - 'MOZ_NO_REMOTE': '1', 08:51:54 INFO - 'NO_EM_RESTART': '1', 08:51:54 INFO - 'PAGER': '/bin/cat', 08:51:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:54 INFO - 'PWD': '/builds/slave/test', 08:51:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:54 INFO - 'SHELL': '/bin/bash', 08:51:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fe1oLN0jyY/Listeners', 08:51:54 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:51:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:54 INFO - 'USER': 'cltbld', 08:51:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:54 INFO - 'XPC_FLAGS': '0x0', 08:51:54 INFO - 'XPC_SERVICE_NAME': '0', 08:51:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:51:54 INFO - Cleaning up... 08:51:54 INFO - Return code: 0 08:51:54 INFO - Running post-action listener: _resource_record_post_action 08:51:54 INFO - Running post-action listener: _start_resource_monitoring 08:51:54 INFO - Starting resource monitoring. 08:51:54 INFO - [mozharness: 2017-01-23 16:51:54.569037Z] Finished create-virtualenv step (success) 08:51:54 INFO - [mozharness: 2017-01-23 16:51:54.570043Z] Running install step. 08:51:54 INFO - Running pre-action listener: _resource_record_pre_action 08:51:54 INFO - Running main action method: install 08:51:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:54 INFO - Reading from file tmpfile_stdout 08:51:54 INFO - Detecting whether we're running mozinstall >=1.0... 08:51:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:51:54 INFO - Reading from file tmpfile_stdout 08:51:54 INFO - Output received: 08:51:54 INFO - Usage: mozinstall [options] installer 08:51:54 INFO - Options: 08:51:54 INFO - -h, --help show this help message and exit 08:51:54 INFO - -d DEST, --destination=DEST 08:51:54 INFO - Directory to install application into. [default: 08:51:54 INFO - "/builds/slave/test"] 08:51:54 INFO - --app=APP Application being installed. [default: firefox] 08:51:54 INFO - mkdir: /builds/slave/test/build/application 08:51:54 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'] 08:51:54 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 08:52:16 INFO - Reading from file tmpfile_stdout 08:52:16 INFO - Output received: 08:52:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:52:16 INFO - Running post-action listener: _resource_record_post_action 08:52:16 INFO - [mozharness: 2017-01-23 16:52:16.417854Z] Finished install step (success) 08:52:16 INFO - [mozharness: 2017-01-23 16:52:16.417998Z] Running run-tests step. 08:52:16 INFO - Running pre-action listener: _resource_record_pre_action 08:52:16 INFO - Running main action method: run_tests 08:52:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:52:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:52:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:52:16 INFO - 2017-01-23 08:52:16.432 screenresolution[1623:7573] starting screenresolution argv=screenresolution get 08:52:16 INFO - 2017-01-23 08:52:16.435 screenresolution[1623:7573] Display 0: 1600x1200x32@60 08:52:16 INFO - 2017-01-23 08:52:16.441 screenresolution[1624:7576] starting screenresolution argv=screenresolution list 08:52:16 INFO - Available Modes on Display 0 08:52:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:52:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:52:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:52:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:52:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:52:16 INFO - Intel Iris: 08:52:16 INFO - Chipset Model: Intel Iris 08:52:16 INFO - Type: GPU 08:52:16 INFO - Bus: Built-In 08:52:16 INFO - VRAM (Dynamic, Max): 1536 MB 08:52:16 INFO - Vendor: Intel (0x8086) 08:52:16 INFO - Device ID: 0x0a2e 08:52:16 INFO - Revision ID: 0x0009 08:52:16 INFO - Displays: 08:52:16 INFO - Display: 08:52:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:52:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:52:16 INFO - Display Serial Number: 1600x1200 60 08:52:16 INFO - Main Display: Yes 08:52:16 INFO - Mirror: Off 08:52:16 INFO - Online: Yes 08:52:16 INFO - Rotation: Supported 08:52:16 INFO - Return code: 0 08:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:52:16 INFO - Python 2.7.3 08:52:16 INFO - Return code: 0 08:52:16 INFO - grabbing minidump binary from tooltool 08:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:16 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 0x10ac9fd30>, '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 0x10ab05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac97b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:52:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:52:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:52:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:52:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:52:16 INFO - Return code: 0 08:52:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:52:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:52:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:52:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:52:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:52:16 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/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0226', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:52:16 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/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0226 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8kNOlchaOC/Render', 08:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:16 INFO - 'HOME': '/Users/cltbld', 08:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:16 INFO - 'LOGNAME': 'cltbld', 08:52:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:16 INFO - 'MOZ_NO_REMOTE': '1', 08:52:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:16 INFO - 'NO_EM_RESTART': '1', 08:52:16 INFO - 'PAGER': '/bin/cat', 08:52:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:16 INFO - 'PWD': '/builds/slave/test', 08:52:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:16 INFO - 'SHELL': '/bin/bash', 08:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fe1oLN0jyY/Listeners', 08:52:16 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:16 INFO - 'USER': 'cltbld', 08:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:16 INFO - 'XPC_FLAGS': '0x0', 08:52:16 INFO - 'XPC_SERVICE_NAME': '0', 08:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:16 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/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0226', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:52:17 INFO - mozversion application_buildid: 20170123062146 08:52:17 INFO - mozversion application_changeset: 76101b503191468724851ba294a3d1fe7d2df50f 08:52:17 INFO - mozversion application_display_name: Firefox 08:52:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:52:17 INFO - mozversion application_name: Firefox 08:52:17 INFO - mozversion application_remotingname: firefox 08:52:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:52:17 INFO - mozversion application_vendor: Mozilla 08:52:17 INFO - mozversion application_version: 52.0 08:52:17 INFO - mozversion platform_buildid: 20170123062146 08:52:17 INFO - mozversion platform_changeset: 76101b503191468724851ba294a3d1fe7d2df50f 08:52:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:52:17 INFO - mozversion platform_version: 52.0 08:52:17 INFO - using testdate: 1485190337 08:52:17 INFO - actual date: 1485190337 08:52:17 INFO - starting webserver on 'localhost:49246' 08:52:17 INFO - SUITE-START | Running 2 tests 08:52:17 INFO - TEST-START | dromaeo_css 08:52:17 INFO - operating with platform_type : mac_ 08:52:17 INFO - Initialising browser for dromaeo_css test... 08:52:17 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpdIugwW/profile http://localhost:49246/getInfo.html) 08:52:19 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 08:52:19 INFO - PROCESS | 1634 | colorDepth:24 08:52:19 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 08:52:19 INFO - PROCESS | 1634 | __metrics 08:52:19 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:52:19 INFO - PROCESS | 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:20 INFO - TEST-INFO | 1634: exit 0 08:52:20 INFO - Browser initialized. 08:52:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:20 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpdIugwW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:32 INFO - PROCESS | 1637 | RSS: Main: 172068864 08:52:32 INFO - PROCESS | 1637 | 08:55:36 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 08:55:38 INFO - PROCESS | 1637 | RSS: Main: 296357888 08:55:38 INFO - PROCESS | 1637 | 08:58:41 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 08:58:41 INFO - PROCESS | 1637 | RSS: Main: 296185856 08:58:41 INFO - PROCESS | 1637 | 09:01:43 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 09:01:44 INFO - PROCESS | 1637 | RSS: Main: 271036416 09:01:44 INFO - PROCESS | 1637 | 09:04:46 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 09:04:47 INFO - PROCESS | 1637 | RSS: Main: 274944000 09:04:47 INFO - PROCESS | 1637 | 09:07:50 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 09:07:51 INFO - PROCESS | 1637 | RSS: Main: 257863680 09:07:51 INFO - PROCESS | 1637 | 09:10:53 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 09:10:54 INFO - PROCESS | 1637 | RSS: Main: 429658112 09:10:54 INFO - PROCESS | 1637 | 09:10:54 INFO - PROCESS | 1637 | __start_tp_report 09:10:54 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 09:10:54 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 09:10:54 INFO - PROCESS | 1637 | |i|pagename|runs| 09:10:54 INFO - PROCESS | 1637 | |0;dojo.html;2941.764658827294;3471;3527.982360088199;3536.169000284933;3599.0102721751514;5964.075568286911;5965.284165900092;5967.582269241155;5972.19375384323;5993.43062409071;5646.378898321192;5942.851428714273;5966.5226781857455;5976.103584462322;5985.850353741159;5284.180951952444;5289.365276166846;5305.920411193835;5351.545118664918;5363.785448582052;5255.316808814849;5260.710660913648;5276.023935571912;5382.381026181981;5436.429174936634;4470.8882277942985;5336.17289320156;5344.625876188668;5350.598705097113;5354.759035843396;5358.383785864637;5362.544183744387;5369.140937449989;5370.087085195487;5373.677579345252;5167.199084141964;5296.602754793406;5299.4700529946695;5302.840914772563;5308.0710875596615;5992.520598352121;6035.185249991239;6058.303295121029;6090.086487026937;6109.266887973427;6172.600330834698;6211.130441738161;6217.56477046607;6224.128621992924;6242.438180563771;6120.264288666148;6167.44492995628;6195.87608247837;6315.336889626569;6337.081123237151;5932.377100404438;5988.221531201003;5995.730192141364;5996.190514280604;5997;6359.682015899187;6377.585456945377;6391.009393544008;6391.392817682406;6408.10286559882;6112.420797151262;6145.477634401037;6187.597806142587;6309;6320.494360451153;6231.906521402183;6242.500599951993;6246.6876656167005;6248.343923887926;6269.435750782452;6282.057691346243;6287.339829317947;6289.339619339903;6290.8427289317215;6319.46284565817;6177.907331390033;6180.907286390708;6214.347493513206;6244.531660125509;6254.3745625438005;5022.447530771612;5025.3718285214345;5032.84901452957;5039.118154322979;5042.596592272609;3828.1769419574925;4505.6846020778885;4573.5426457354;4574.4510658721165;4587.79354929029;5956.791512297049;6053.092036194606;6076.3316035236085;6084.60450070744;6092.268927728701;6261.186045814015;6275.215598050244;6281.8743625127245;6283.08895210192;6286.371362863677;5853.912191317134;5930.258717660293;5933.881322373529;5991.910121348184;6002.279726432856;5538.086215774352;5538.556915446755;5544;5551.000819852466;5551.084071128299;6253.906191407133;6277.403646653744;6298.622082675054;6311.810645680637;6324.209473815773;6192.566520343533;6246.281677607133;6261.279952805486;6264.123022776724;6267.373262673696;6420.903686444613;6426.100345951664;6431.935680643133;6435.002574600944;6444.871102578016;6080.604760690541;6162.661053641913;6224.533160012927;6242.157308763259;6252.781152659635;6165.815025549241;6189.876202475835;6224.1597384352535;6246.5002799775;6247.375262473716;6153;6278.529110316653;6288.496920246278;6302.621842689453;6318.652474113968;4900;6255.24937007562;6267.185265915402;6278.121063051085;6287.245530536365;6030.185924900083;6102.572819902742;6121.693915304306;6135.44703110649;6140.293866205444;6290.21372328459;6293.653849038347;6295.3389894060465;6295.905561416491;6306.337834527309;6218.968905155445;6222.502199823913;6229.53278504123;6240.594361366497;6250.4374606285655 09:10:54 INFO - PROCESS | 1637 | |1;ext.html;484.76488902882096;527.9868003299919;529.2326127115682;551.8068675963414;559.4824787071963;30876.84561577192;32780.34439311215;32784.836075819614;38364.42453363195;39870.8006459968;43497.565024349744;43707;43737.56262437375;43883;44024.779876100576;9604.951975240114;9790.755231119243;9809.117179453848;9818.312718109735;9823.50882455878;8942.687005954793;9157.038510956354;9600.087991640783;9702.66040688576;11611.129165312635;11671.1830171888;11979.460924258387;11988.760224795498;12003.459844306983;12011.27932324059;11910.702232444171;11939.34333611651;11948.402579871059;11962.940185299018;11964.40177991097;11739.765204695857;11749.882501174965;11779.941100294529;11802.11484138693;11825.231359961661;40186.39720404196;40441.59558404437;40490;40492.797536012426;40559.594404055875;3412.3004784019217;3591.4434457152506;3654.9948764089822;3958.386450100239;4063.471748672683;29391.85304073466;29638.55542166869;29749;30027.69972300271;32014.839925800454;3197.6322722886935;3268.3953468608383;3285.0965984354257;3358;3403.5405220295193;501551;501850;504403;657062;657893;34273.14317142092;34836.651633483845;60085;60736.69631651902;60813.783724325265;36366.63633363685;36425.453618195745;36520.904372868856;36577;36621.450678239846;13234.205947643171;14926.179060151579;15100.697986040217;15270.007449515746;15394.307256173499;12844.422001009976;12954.028447866447;12957.481700731865;13003.609891703263;13015;7485.812854678677;7654.808629784188;7913.723019694398;8161.224683655043;8188.26305632484;3337.499375093707;3378.2567835076734;3385.170633194834;3393.236521782579;3415.1291420688062;975.380633297861;1009.1573536097441;1029.8506716526063;1033.509083185496;1052.8104941110673;30201.09396718102;30426.695733042387;30518.62666179983;30667.69332306693;30948.40769725075;1115.16919894679;1140.9372484513265;1163.040491594438;1168.661088284388;1209.9516019359303;15589;15789.36842526309;15856.920715396349;15892.602684932737;16254.349826007065;691676;697146;698031;698786;699624;59526.40473595295;59996.400035999955;60148.09777853336;60236;60477.69761151254;1273.0961017677369;1325.1651459580403;1397.5946975377026;1428.350100704177;1452.0924422236103;30210.54684179695;30407.847960760053;30933.690663093083;31367.05898823039;31636.36727265396;43857.903552411444;46760;48954.75522622364;49483;49577.75211123921;463539;465058;467972;468902;804317;26530.336741581614;27233.72766272391;27272.909083636434;27888.44223115486;27890.581641275803;46524.767376162905;47138;47199.52800471951;47624.523754762005;47784.761076194394;38771.41842872416;39503.80248098741;39603.811885643474;39775;41074.79462602788;39165.82502524929;39302;39774.40338394869;40264;40608.39087413632;37994.81002594969;38363.23273534569;39010;39240.82277531679;39554.40668390034;32808.34383312368;33984.8905134933;34295.828520857234;34540.481892771124;34718.65281347154;25604.743952560235;25856.353591160372;25969.091081812046;26141.73858261393;26420.867895660398 09:10:54 INFO - PROCESS | 1637 | |2;jquery.html;374.59730789401385;386.40107832859064;389.2740039825726;399.1577770903393;406.42085028833907;19288.3249086282;21077.894610526924;21577.4605634859;21806.781932180675;22132.778672213273;17556.297748090063;20786.792132078674;21198.89400552999;21722.239721609745;21764.45588860279;5978.192943952576;6063.484603808682;6188.381161883821;6248.125262463259;6253.749850005995;4416.668749843759;4649.232876575378;6120.26556813183;6224;6224.346443623423;5442.673439593617;6826.897596536056;6878.793636190922;6957.6521173941355;6977.9302206978045;6628.270890202074;6870.484713646471;6917.7578784742545;6918.619475928822;6940.271271516519;5981.671008094553;6029.8191054268445;6056.182415373913;6077.483413909823;6120.693965301717;26368.20895373142;26519.76668826949;26714;27253;27418.725812741817;2004.6992951057457;2460.335709358481;2489.35276828026;2500.5124000819847;2506.94986100277;16327.428540001043;16568.502944911674;16709.415170468976;16794.916025419796;17118.828811711846;1791.8208179182109;1884.896330701811;1949.9025048747505;1955.6284305981817;1984.3848406993877;107456;108664.91335086626;111264;114758.99999999917;115766;11535.538578456768;11564.074874010059;11690.532378704927;11713;11857.822132668018;15210;15247.390104395921;15249.085054896519;15278.31247593861;15287.770683439758;6221.844453888689;6393.744250229939;8837.337199710048;8849;8970.596323165473;8744;8749.693760718344;8752.606132724042;8896.110388961182;8936.882889638795;4621.468531118964;4703.976480117578;4716.3632909557455;4729.219678753036;4762.904741905212;1811.8459930905758;1841.0142042478153;1960.2061165228106;2002.8497862660358;2003.7294965179806;818.9467684600481;963.5904740485265;990.7325022243954;991.3902949685892;1013.7972405518778;20870;22167.77832221657;22247.888760556092;22266;22267.777322226895;934.0939288889766;971.2230215827451;972.7665360313474;994.6121012805012;1008.1884083313004;9051.823262975771;10344;11735.119866010084;11816.172867899164;11844.644660660195;602758;603313.98343008;608841.9557902182;617442;617892;122180.38909805572;123558;126605;127319;131277;852.6291063387446;962.4225464721111;983.1839573154265;1004.1866088468219;1006.2000709436016;16714.832851671326;17557.561060973578;19497;19568;19628;49961.75019124881;51426;52491.47508525019;53274;53643;72312;74407.25592744003;75182.24817751753;75885.620571899;75991;8040.839183216186;8207.466514676527;8293;8398.496090234605;8405.747827565183;8817.867731983897;12609.87390126087;12726.300053497147;13051.608451746462;13187.67030824237;10134.949325253327;10264.973502649975;10997.780044399227;11179.944100279447;11459.828102578635;10993.450327483753;11073.50169242402;11195.776084478428;11203.428328244629;11337.659870203906;9612.327137100336;10434.321769084985;10725.105636610037;11451.828222576834;11581.42092895335;8145.144759800136;8456.238938495564;11734.765304694029;12038.337891416057;12653.74692506163;10684;11795.646130615753;11825.82261266099;11906.285622862655;11942.701432464259 09:10:54 INFO - PROCESS | 1637 | |3;mootools.html;1512.2212060788695;1532.348751780493;1737.4005967941057;1891.527118220445;1915.770107587089;7252.2747725227455;8095.352371810256;8520.105388934158;8520.318374530038;8525.786855328612;7483.401327893769;7739.690412383512;7742.767716968486;7834.72578459754;7847.293743563093;2159.773223811497;2317.5480781247666;2386.677798497198;2393.6888204533475;2407.325948734357;2404.1488054198257;2421.9757802422014;2433.2092070077297;2433.5376278507115;2438.036975394718;2379.310000099969;2403.663487111806;2406.74729153439;2408.0247499762536;2415.6255780353986;2346.730126035502;2378.9048438062455;2383.9046438142454;2384.9046038158453;2386.940326491834;2386.0813586769045;2392.653065305521;2412.3124909400735;2414.517096580691;2417.033186725324;8265.669373225124;8417.410781245315;8426.536540490271;8448;8510.957445212796;5075.898482030376;5233.4243233244315;5236.240745091978;5248.685078895279;5248.790048398059;2969.717876801722;3320.452125399306;3492;3559.501669766209;3566.35805555;1022.1771473963456;1062.697131317571;1087.065123993365;1095.956161753537;1099.5272033025797;10817;10827.783444331148;10835.970582794622;10847.45762711869;10877.347359158475;4508.436445444319;4734.692245004064;4795.544423279783;4799.448063472675;4809.639277054235;9466.952665236768;9479.573419196153;9494.905050949541;9502;9538;5244.737763111829;5245.239440281214;5246.947530524722;5250.343707036621;5260.710660913686;4414.558544145624;4595.885102872455;4767.809287628525;4788.401449818773;4861.319415281863;3614.4216925291826;3729.272791805572;3739.289534988398;3740.7194460415576;3746.550413950343;1030.7732298894232;1273.6943133647858;1298.461138627478;1303.5828534868751;1305.106002388367;855.7347222361088;857.3012994409536;871.9825603487894;892.1881088209827;895.9964839379936;5112.948870511322;5717.628354156966;5794.478496935296;5982.820515384546;6059.030555111161;954.9331546791797;969.6363863551169;974.171953839231;984.532347135105;1000.8798944126752;3525.506429099928;3527.365074286653;3555.839987200582;3677.896631010686;3710.888673339804;9679.903200968041;10097.394156350643;10114.59541618327;10127.898721012696;10127.898721012843;7429.62851857405;9981.950090249502;9993.750156246151;9994.800103997879;10008.899911000943;7627.5042122261875;7890.171531989288;7902.960485197652;7908.130105688369;7918.881216781753;5708.343540492897;5732.971335143297;5736.282964629421;5830.5044071254415;5913.02435098204;9424.528773561431;9427.24582033422;9431.386959847589;9434.716958491255;9451.763705907408;9338.39300445496;9443.338966272295;9567.37812042215;9650.372725772802;9691.563879625293;7062.964685176747;7184.856302873809;7262.491625586158;7275.054242948383;7312.817179570553;7164.140303163654;7411.666475008746;7761.107472640719;7841.255080767318;7857.724979625686;6801.659917004031;7044.542104763174;7177.533460325062;7189.245129261352;7197.424206063607;6996.265392133752;6996.510244282851;7020.227774944854;7046.718131274692;7133.785986420416;6631.303713110054;6735.898961515679;6745.190577130776;6767.593944363354;6768.289329620319;4787.712737235777;4788.6662570373865;4902.3872015998;4925.408950925912;5032.018756342624;4795.424549053996;4876.097921884321;4905;4987.12725273083;4990.126727822689 09:10:54 INFO - PROCESS | 1637 | |4;prototype.html;259.222333000997;312.5218415823789;315.49993260681816;325.2681466699925;328.86516528223433;4990.800367985281;5044.26858105575;5166.302549155863;5306.602004849642;5450.465533526904;5132.5124113209185;5252.789888404469;5265.842024739254;5351.491608297215;5395.865103372417;4132.8140233689555;4148.191102734968;4151.771652559108;4162.916741665173;4171.207470580595;3762.454444105603;3855.575886652466;4047.575004624516;4122.484689413824;4135.958640413603;3707.480952666629;4049.412835138903;4052.371882358239;4066.6949978751713;4072.450219220412;4026.2551427985622;4031.8588849390276;4032.9395059074136;4063.634272915422;4079.4084857695466;3021.773366997462;3375.662433756629;3476.3394954958476;3497.4054410749977;3572.7677700949357;4387.802548885308;5061.696298222082;5221.702450921621;5247.47525247476;5249.4750524947585;4067.9186416271805;4239.58343744066;4658.574354363334;4669.369635099252;4680.057776022946;4909.091818013679;4924.8276310328965;4935.851924442272;5388.491222457718;5659.660420374749;3582.462630605404;3856.402257650069;3893.6301051400073;3897.57126716061;3924.352481840493;5437.9124175165125;5570.220169176318;5635.1828984797385;5681.488666020078;5948.345681974979;3645.5807582128396;3946.4869566956113;3963.8612648557164;3970.895425424472;3981.2634662587516;3860.7104467165077;4002.479677641888;4008.9198216035516;4019;4033.576474470197;4597.287420449836;4627.8611641650805;4633.305004249322;4633.49031606523;4649.325847752057;5657.971710141505;5658.801941932013;5663.575231857545;5666.631668941505;5695.234477312047;1116.4473585575192;1221.2428294457493;1258.5469231076804;1275.8071203424827;1293.7412517496539;737.5095561451575;817.2644619842071;860.5955201055494;875.1773333066897;878.5958459108881;4182.811773470201;4989.950100498949;5002.849914502571;5003.573266965519;5009.5491405773655;4473.888152796141;5054.898902021939;5450.781968721207;5477.616566840363;5542.667439953616;4135.731177473454;4234.449521562239;4711;4937.703737775673;4964.776585053682;2478.714947780992;2580.354911272182;2620.7379262074023;2785.1505290886475;2889.179816715498;5213.765380557884;5668.971655141698;5680.488756011979;5705.74324155414;5708.40061793514;4889.828855990023;5309.33633295838;5511.366192887789;5597.3003374578175;5631.521320687705;5219.460259223614;6024.096385542116;6118.3269840317525;6131.908021379683;6150.661713605795;5902.085176797603;5909.320428150818;5919.6744179070565;5930.495907847881;5950.434708702666;5546.278983732089;5801.970990145022;5815.331236907809;5833;5842.561807864342;6077.088436734525;6083.66539840313;6105;6116.724747386289;6147.280895058425;3360.059183428644;3783.319002579452;3947.526296844397;3981.8407263709128;4128.298189307765;4892.899097702988;5746.270521502253;5842.429331094305;5892.261782774178;5924.377940316377;4261.062566235423;4945.826896058621;5651.943480565142;5669.773209071756;5705.62913410627;5459.5632349412745;5496.801279488077;5509.5041446270025;5680.6591604503865;5786.396121745147;4401.515833258403;4928.605711542997;4936.975315123402;5504.889902201853;5721.427857214246;4977.8257760978195;5602.803901863415;5747.655140691572;5781.364049954417;5791.594588378773;4789.3055506952;5673.602847800615;5675.177099320658;5688.601797874109;5730.455606717355 09:10:54 INFO - PROCESS | 1637 | |5;yui.html;687.6424259385122;731.535474973392;780.1184661332696;834.1019766530791;838.7232213369581;14537.49118780843;15680.059196448221;15700.293486793093;15722.371105155795;15755.369785208592;14019.789703154462;14182.71634567308;14188.07777494462;14191.716165676706;14199.14805111694;698.2528694297079;715.8818794898835;722.68201991124;724.8912663100524;891.0376793063476;716.6774951271923;722.7795522365676;859.188067276424;887.525174031893;895.082540396096;950.410745337888;960.2270172511126;961.0821665309647;965.030144704571;967.4823969176492;959.2421986630553;960.5389413081759;960.9231261499064;961.4663861556833;965.6861520005956;713.5148099292479;714.1287629092499;715.0454143718142;715.7101373943561;718.3965469006008;14508;14524.927375363055;14576;14597.70804583913;15095.773563396559;13531.458741650322;13988.460563653187;14037.214015358471;14127.223002734845;14256.786148207786;11191.440427978569;11386.829197562043;11511;11680.532778688843;11807.291562506278;3733.1413774831667;3907.7459965102175;3911.3350730375905;3957.8021098944937;4021.7989100544855;89159;92799;93327.60008599877;94422.5278873608;94866;10820.78358432827;10893.400862952614;11109.333439993627;11307.265027773168;11690.240134391408;21941.01265443059;22101.778982209973;22216.444588885082;22269.66595501069;22276.443088922584;7833.167825223436;7845.254700803414;7852.254035866584;7891.802704932308;7936.2857342839425;4216.409702641633;4282.957170428318;4360.520342762294;4395.099004704028;4405.669574781904;3204.34310966256;3281.950770738441;3366.8316584170693;3488.8255587220538;3493.4235851084795;612.761023200952;620.8292719502173;624.6814124796296;647.6437959122558;648.4002297874447;653.859420224654;655.131950166032;674.5817593092314;686.8111269400955;690.3303795318533;8523.505646635746;9132.20559206422;9183.816323673489;9209.723708288762;9278.536073196314;641.1216633212529;674.9021391898148;678.7522554267657;692.6917521702794;697.5082566790401;4418.8453404130705;4432.202203603318;4436.600705936481;4486.910261794811;4524.140413321458;76373;96869;111310.44344778224;114398.42800785943;115529;92426.0757392431;97884.51057744665;99888;100071.99928000773;100838;81291.5935420331;81678;82021.17978820254;82358;84729;8691.86962195555;8756.868646970428;8769.693060742844;8875.600597973236;8942;50861;51372.74313628557;55082.72458637841;55320.72339638276;55810;56911;58258;77400.2259977393;79400;82624;11995.280283183038;12975;13050.608481745563;13379.029582048068;13458.865411345761;14151.929240353733;14513.05665131763;14774.409023638935;14776.187309698069;14932.328045237773;11409.20135590534;12860.90543159576;13837.962152838778;13923.860761392256;14338.283085845458;13433.19400835953;13689.772336062777;13722.65693357674;13747.656308591964;13881.236531990837;12851.485940562647;13105.951523878257;13189.670258243237;13364.465421383036;13384.531541396005;10155.84766228522;10754.516046777757;10975.670729878117;11170.72073198144;11781.587644432404;10806.18953578469;11254.94372528132;11547.422628868691;11575.826362604399;11610.361430121424 09:10:54 INFO - PROCESS | 1637 | __end_tp_report 09:10:54 INFO - PROCESS | 1637 | __start_cc_report 09:10:54 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1323 09:10:54 INFO - PROCESS | 1637 | __end_cc_report 09:10:54 INFO - PROCESS | 1637 | __startTimestamp1485191454143__endTimestamp 09:10:54 INFO - PROCESS | 1637 | 09:10:54 INFO - PROCESS | 1637 | ------- Summary: start ------- 09:10:54 INFO - PROCESS | 1637 | Number of tests: 6 09:10:54 INFO - PROCESS | 1637 | 09:10:54 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5852.25 Median:6135.45 stddev:653.58 (10.7%) stddev-sans-first:614.42 09:10:54 INFO - PROCESS | 1637 | Values: 2941.8 3471.0 3528.0 3536.2 3599.0 5964.1 5965.3 5967.6 5972.2 5993.4 5646.4 5942.9 5966.5 5976.1 5985.9 5284.2 5289.4 5305.9 5351.5 5363.8 5255.3 5260.7 5276.0 5382.4 5436.4 4470.9 5336.2 5344.6 5350.6 5354.8 5358.4 5362.5 5369.1 5370.1 5373.7 5167.2 5296.6 5299.5 5302.8 5308.1 5992.5 6035.2 6058.3 6090.1 6109.3 6172.6 6211.1 6217.6 6224.1 6242.4 6120.3 6167.4 6195.9 6315.3 6337.1 5932.4 5988.2 5995.7 5996.2 5997.0 6359.7 6377.6 6391.0 6391.4 6408.1 6112.4 6145.5 6187.6 6309.0 6320.5 6231.9 6242.5 6246.7 6248.3 6269.4 6282.1 6287.3 6289.3 6290.8 6319.5 6177.9 6180.9 6214.3 6244.5 6254.4 5022.4 5025.4 5032.8 5039.1 5042.6 3828.2 4505.7 4573.5 4574.5 4587.8 5956.8 6053.1 6076.3 6084.6 6092.3 6261.2 6275.2 6281.9 6283.1 6286.4 5853.9 5930.3 5933.9 5991.9 6002.3 5538.1 5538.6 5544.0 5551.0 5551.1 6253.9 6277.4 6298.6 6311.8 6324.2 6192.6 6246.3 6261.3 6264.1 6267.4 6420.9 6426.1 6431.9 6435.0 6444.9 6080.6 6162.7 6224.5 6242.2 6252.8 6165.8 6189.9 6224.2 6246.5 6247.4 6153.0 6278.5 6288.5 6302.6 6318.7 4900.0 6255.2 6267.2 6278.1 6287.2 6030.2 6102.6 6121.7 6135.4 6140.3 6290.2 6293.7 6295.3 6295.9 6306.3 6219.0 6222.5 6229.5 6240.6 6250.4 09:10:54 INFO - PROCESS | 1637 | 09:10:54 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:71530.62 Median:19214.05 stddev:163575.11 (851.3%) stddev-sans-first:163947.01 09:10:54 INFO - PROCESS | 1637 | Values: 484.8 528.0 529.2 551.8 559.5 30876.8 32780.3 32784.8 38364.4 39870.8 43497.6 43707.0 43737.6 43883.0 44024.8 9605.0 9790.8 9809.1 9818.3 9823.5 8942.7 9157.0 9600.1 9702.7 11611.1 11671.2 11979.5 11988.8 12003.5 12011.3 11910.7 11939.3 11948.4 11962.9 11964.4 11739.8 11749.9 11779.9 11802.1 11825.2 40186.4 40441.6 40490.0 40492.8 40559.6 3412.3 3591.4 3655.0 3958.4 4063.5 29391.9 29638.6 29749.0 30027.7 32014.8 3197.6 3268.4 3285.1 3358.0 3403.5 501551.0 501850.0 504403.0 657062.0 657893.0 34273.1 34836.7 60085.0 60736.7 60813.8 36366.6 36425.5 36520.9 36577.0 36621.5 13234.2 14926.2 15100.7 15270.0 15394.3 12844.4 12954.0 12957.5 13003.6 13015.0 7485.8 7654.8 7913.7 8161.2 8188.3 3337.5 3378.3 3385.2 3393.2 3415.1 975.4 1009.2 1029.9 1033.5 1052.8 30201.1 30426.7 30518.6 30667.7 30948.4 1115.2 1140.9 1163.0 1168.7 1210.0 15589.0 15789.4 15856.9 15892.6 16254.3 691676.0 697146.0 698031.0 698786.0 699624.0 59526.4 59996.4 60148.1 60236.0 60477.7 1273.1 1325.2 1397.6 1428.4 1452.1 30210.5 30407.8 30933.7 31367.1 31636.4 43857.9 46760.0 48954.8 49483.0 49577.8 463539.0 465058.0 467972.0 468902.0 804317.0 26530.3 27233.7 27272.9 27888.4 27890.6 46524.8 47138.0 47199.5 47624.5 47784.8 38771.4 39503.8 39603.8 39775.0 41074.8 39165.8 39302.0 39774.4 40264.0 40608.4 37994.8 38363.2 39010.0 39240.8 39554.4 32808.3 33984.9 34295.8 34540.5 34718.7 25604.7 25856.4 25969.1 26141.7 26420.9 09:10:54 INFO - PROCESS | 1637 | 09:10:54 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:35442.24 Median:2474.84 stddev:101399.32 (4097.2%) stddev-sans-first:101649.58 09:10:54 INFO - PROCESS | 1637 | Values: 374.6 386.4 389.3 399.2 406.4 19288.3 21077.9 21577.5 21806.8 22132.8 17556.3 20786.8 21198.9 21722.2 21764.5 5978.2 6063.5 6188.4 6248.1 6253.7 4416.7 4649.2 6120.3 6224.0 6224.3 5442.7 6826.9 6878.8 6957.7 6977.9 6628.3 6870.5 6917.8 6918.6 6940.3 5981.7 6029.8 6056.2 6077.5 6120.7 26368.2 26519.8 26714.0 27253.0 27418.7 2004.7 2460.3 2489.4 2500.5 2506.9 16327.4 16568.5 16709.4 16794.9 17118.8 1791.8 1884.9 1949.9 1955.6 1984.4 107456.0 108664.9 111264.0 114759.0 115766.0 11535.5 11564.1 11690.5 11713.0 11857.8 15210.0 15247.4 15249.1 15278.3 15287.8 6221.8 6393.7 8837.3 8849.0 8970.6 8744.0 8749.7 8752.6 8896.1 8936.9 4621.5 4704.0 4716.4 4729.2 4762.9 1811.8 1841.0 1960.2 2002.8 2003.7 818.9 963.6 990.7 991.4 1013.8 20870.0 22167.8 22247.9 22266.0 22267.8 934.1 971.2 972.8 994.6 1008.2 9051.8 10344.0 11735.1 11816.2 11844.6 602758.0 603314.0 608842.0 617442.0 617892.0 122180.4 123558.0 126605.0 127319.0 131277.0 852.6 962.4 983.2 1004.2 1006.2 16714.8 17557.6 19497.0 19568.0 19628.0 49961.8 51426.0 52491.5 53274.0 53643.0 72312.0 74407.3 75182.2 75885.6 75991.0 8040.8 8207.5 8293.0 8398.5 8405.7 8817.9 12609.9 12726.3 13051.6 13187.7 10134.9 10265.0 10997.8 11179.9 11459.8 10993.5 11073.5 11195.8 11203.4 11337.7 9612.3 10434.3 10725.1 11451.8 11581.4 8145.1 8456.2 11734.8 12038.3 12653.7 10684.0 11795.6 11825.8 11906.3 11942.7 09:10:54 INFO - PROCESS | 1637 | 09:10:54 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5455.16 Median:5244.99 stddev:2943.40 (56.1%) stddev-sans-first:2936.74 09:10:54 INFO - PROCESS | 1637 | Values: 1512.2 1532.3 1737.4 1891.5 1915.8 7252.3 8095.4 8520.1 8520.3 8525.8 7483.4 7739.7 7742.8 7834.7 7847.3 2159.8 2317.5 2386.7 2393.7 2407.3 2404.1 2422.0 2433.2 2433.5 2438.0 2379.3 2403.7 2406.7 2408.0 2415.6 2346.7 2378.9 2383.9 2384.9 2386.9 2386.1 2392.7 2412.3 2414.5 2417.0 8265.7 8417.4 8426.5 8448.0 8511.0 5075.9 5233.4 5236.2 5248.7 5248.8 2969.7 3320.5 3492.0 3559.5 3566.4 1022.2 1062.7 1087.1 1096.0 1099.5 10817.0 10827.8 10836.0 10847.5 10877.3 4508.4 4734.7 4795.5 4799.4 4809.6 9467.0 9479.6 9494.9 9502.0 9538.0 5244.7 5245.2 5246.9 5250.3 5260.7 4414.6 4595.9 4767.8 4788.4 4861.3 3614.4 3729.3 3739.3 3740.7 3746.6 1030.8 1273.7 1298.5 1303.6 1305.1 855.7 857.3 872.0 892.2 896.0 5112.9 5717.6 5794.5 5982.8 6059.0 954.9 969.6 974.2 984.5 1000.9 3525.5 3527.4 3555.8 3677.9 3710.9 9679.9 10097.4 10114.6 10127.9 10127.9 7429.6 9982.0 9993.8 9994.8 10008.9 7627.5 7890.2 7903.0 7908.1 7918.9 5708.3 5733.0 5736.3 5830.5 5913.0 9424.5 9427.2 9431.4 9434.7 9451.8 9338.4 9443.3 9567.4 9650.4 9691.6 7063.0 7184.9 7262.5 7275.1 7312.8 7164.1 7411.7 7761.1 7841.3 7857.7 6801.7 7044.5 7177.5 7189.2 7197.4 6996.3 6996.5 7020.2 7046.7 7133.8 6631.3 6735.9 6745.2 6767.6 6768.3 4787.7 4788.7 4902.4 4925.4 5032.0 4795.4 4876.1 4905.0 4987.1 4990.1 09:10:54 INFO - PROCESS | 1637 | 09:10:54 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4535.46 Median:4990.38 stddev:1415.37 (28.4%) stddev-sans-first:1382.47 09:10:54 INFO - PROCESS | 1637 | Values: 259.2 312.5 315.5 325.3 328.9 4990.8 5044.3 5166.3 5306.6 5450.5 5132.5 5252.8 5265.8 5351.5 5395.9 4132.8 4148.2 4151.8 4162.9 4171.2 3762.5 3855.6 4047.6 4122.5 4136.0 3707.5 4049.4 4052.4 4066.7 4072.5 4026.3 4031.9 4032.9 4063.6 4079.4 3021.8 3375.7 3476.3 3497.4 3572.8 4387.8 5061.7 5221.7 5247.5 5249.5 4067.9 4239.6 4658.6 4669.4 4680.1 4909.1 4924.8 4935.9 5388.5 5659.7 3582.5 3856.4 3893.6 3897.6 3924.4 5437.9 5570.2 5635.2 5681.5 5948.3 3645.6 3946.5 3963.9 3970.9 3981.3 3860.7 4002.5 4008.9 4019.0 4033.6 4597.3 4627.9 4633.3 4633.5 4649.3 5658.0 5658.8 5663.6 5666.6 5695.2 1116.4 1221.2 1258.5 1275.8 1293.7 737.5 817.3 860.6 875.2 878.6 4182.8 4990.0 5002.8 5003.6 5009.5 4473.9 5054.9 5450.8 5477.6 5542.7 4135.7 4234.4 4711.0 4937.7 4964.8 2478.7 2580.4 2620.7 2785.2 2889.2 5213.8 5669.0 5680.5 5705.7 5708.4 4889.8 5309.3 5511.4 5597.3 5631.5 5219.5 6024.1 6118.3 6131.9 6150.7 5902.1 5909.3 5919.7 5930.5 5950.4 5546.3 5802.0 5815.3 5833.0 5842.6 6077.1 6083.7 6105.0 6116.7 6147.3 3360.1 3783.3 3947.5 3981.8 4128.3 4892.9 5746.3 5842.4 5892.3 5924.4 4261.1 4945.8 5651.9 5669.8 5705.6 5459.6 5496.8 5509.5 5680.7 5786.4 4401.5 4928.6 4937.0 5504.9 5721.4 4977.8 5602.8 5747.7 5781.4 5791.6 4789.3 5673.6 5675.2 5688.6 5730.5 09:10:54 INFO - PROCESS | 1637 | 09:10:54 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20639.61 Median:4425.52 stddev:29738.71 (672.0%) stddev-sans-first:29784.39 09:10:54 INFO - PROCESS | 1637 | Values: 687.6 731.5 780.1 834.1 838.7 14537.5 15680.1 15700.3 15722.4 15755.4 14019.8 14182.7 14188.1 14191.7 14199.1 698.3 715.9 722.7 724.9 891.0 716.7 722.8 859.2 887.5 895.1 950.4 960.2 961.1 965.0 967.5 959.2 960.5 960.9 961.5 965.7 713.5 714.1 715.0 715.7 718.4 14508.0 14524.9 14576.0 14597.7 15095.8 13531.5 13988.5 14037.2 14127.2 14256.8 11191.4 11386.8 11511.0 11680.5 11807.3 3733.1 3907.7 3911.3 3957.8 4021.8 89159.0 92799.0 93327.6 94422.5 94866.0 10820.8 10893.4 11109.3 11307.3 11690.2 21941.0 22101.8 22216.4 22269.7 22276.4 7833.2 7845.3 7852.3 7891.8 7936.3 4216.4 4283.0 4360.5 4395.1 4405.7 3204.3 3282.0 3366.8 3488.8 3493.4 612.8 620.8 624.7 647.6 648.4 653.9 655.1 674.6 686.8 690.3 8523.5 9132.2 9183.8 9209.7 9278.5 641.1 674.9 678.8 692.7 697.5 4418.8 4432.2 4436.6 4486.9 4524.1 76373.0 96869.0 111310.4 114398.4 115529.0 92426.1 97884.5 99888.0 100072.0 100838.0 81291.6 81678.0 82021.2 82358.0 84729.0 8691.9 8756.9 8769.7 8875.6 8942.0 50861.0 51372.7 55082.7 55320.7 55810.0 56911.0 58258.0 77400.2 79400.0 82624.0 11995.3 12975.0 13050.6 13379.0 13458.9 14151.9 14513.1 14774.4 14776.2 14932.3 11409.2 12860.9 13838.0 13923.9 14338.3 13433.2 13689.8 13722.7 13747.7 13881.2 12851.5 13106.0 13189.7 13364.5 13384.5 10155.8 10754.5 10975.7 11170.7 11781.6 10806.2 11254.9 11547.4 11575.8 11610.4 09:10:54 INFO - PROCESS | 1637 | -------- Summary: end -------- 09:10:54 INFO - PROCESS | 1637 | 09:10:54 INFO - TEST-INFO | 1637: exit 0 09:10:54 INFO - TEST-OK | dromaeo_css | took 1117740ms 09:10:54 INFO - TEST-START | kraken 09:10:54 INFO - operating with platform_type : mac_ 09:10:54 INFO - Initialising browser for kraken test... 09:10:54 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpaCM5oP/profile http://localhost:49246/getInfo.html) 09:10:57 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 09:10:57 INFO - PROCESS | 1646 | colorDepth:24 09:10:57 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 09:10:57 INFO - PROCESS | 1646 | __metrics 09:10:57 INFO - PROCESS | 1646 | 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" 09:10:57 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:58 INFO - TEST-INFO | 1646: exit 0 09:10:58 INFO - Browser initialized. 09:10:58 INFO - Running cycle 1/1 for kraken test... 09:10:58 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpaCM5oP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:10 INFO - PROCESS | 1648 | RSS: Main: 171986944 09:11:10 INFO - PROCESS | 1648 | 09:11:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:13 INFO - PROCESS | 1648 | RSS: Main: 221474816 09:11:13 INFO - PROCESS | 1648 | 09:11:16 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 09:11:17 INFO - PROCESS | 1648 | RSS: Main: 234725376 09:11:17 INFO - PROCESS | 1648 | 09:11:20 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 09:11:20 INFO - PROCESS | 1648 | RSS: Main: 330461184 09:11:20 INFO - PROCESS | 1648 | 09:11:22 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 09:11:23 INFO - PROCESS | 1648 | RSS: Main: 232022016 09:11:23 INFO - PROCESS | 1648 | 09:11:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:25 INFO - PROCESS | 1648 | RSS: Main: 234295296 09:11:25 INFO - PROCESS | 1648 | 09:11:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 09:11:29 INFO - PROCESS | 1648 | RSS: Main: 274481152 09:11:29 INFO - PROCESS | 1648 | 09:11:32 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:32 INFO - PROCESS | 1648 | RSS: Main: 274452480 09:11:32 INFO - PROCESS | 1648 | 09:11:35 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 09:11:35 INFO - PROCESS | 1648 | RSS: Main: 274522112 09:11:35 INFO - PROCESS | 1648 | 09:11:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:38 INFO - PROCESS | 1648 | RSS: Main: 248471552 09:11:38 INFO - PROCESS | 1648 | 09:11:40 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:40 INFO - PROCESS | 1648 | RSS: Main: 250163200 09:11:40 INFO - PROCESS | 1648 | 09:11:42 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:11:43 INFO - PROCESS | 1648 | RSS: Main: 252796928 09:11:43 INFO - PROCESS | 1648 | 09:11:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:11:47 INFO - PROCESS | 1648 | RSS: Main: 265658368 09:11:47 INFO - PROCESS | 1648 | 09:11:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:11:50 INFO - PROCESS | 1648 | RSS: Main: 264589312 09:11:50 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 09:11:52 INFO - PROCESS | 1648 | RSS: Main: 309084160 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | __start_tp_report 09:11:52 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 09:11:52 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 09:11:52 INFO - PROCESS | 1648 | |i|pagename|runs| 09:11:52 INFO - PROCESS | 1648 | |0;ai-astar;116;113;114;113;113;114;113;115;114;114 09:11:52 INFO - PROCESS | 1648 | |1;audio-beat-detection;143;108;108;143;105;108;107;109;136;108 09:11:52 INFO - PROCESS | 1648 | |2;audio-dft;184;185;180;183;182;180;180;184;182;184 09:11:52 INFO - PROCESS | 1648 | |3;audio-fft;81;57;57;86;59;67;54;69;76;53 09:11:52 INFO - PROCESS | 1648 | |4;audio-oscillator;83;69;92;68;67;69;88;67;70;90 09:11:52 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;88;84;86;85;86;85;89;85;87;83 09:11:52 INFO - PROCESS | 1648 | |6;imaging-darkroom;92;92;93;106;150;117;93;93;93;93 09:11:52 INFO - PROCESS | 1648 | |7;imaging-desaturate;81;82;82;81;83;83;83;83;83;80 09:11:52 INFO - PROCESS | 1648 | |8;json-parse-financial;51;50;50;52;56;56;57;56;54;55 09:11:52 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;63;68;73;73;74;98;98;69;68;68 09:11:52 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;82;82;83;82;82;82;81;83;81;86 09:11:52 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;135;136;135;156;153;151;139;140;221;154 09:11:52 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;161;161;161;161;162;161;161;160;161;161 09:11:52 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;66;66;68;67;67;65;65;66;65;65 09:11:52 INFO - PROCESS | 1648 | __end_tp_report 09:11:52 INFO - PROCESS | 1648 | __start_cc_report 09:11:52 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1881 09:11:52 INFO - PROCESS | 1648 | __end_cc_report 09:11:52 INFO - PROCESS | 1648 | __startTimestamp1485191512385__endTimestamp 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | ------- Summary: start ------- 09:11:52 INFO - PROCESS | 1648 | Number of tests: 14 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.99 (0.9%) stddev-sans-first:0.71 09:11:52 INFO - PROCESS | 1648 | Values: 116.0 113.0 114.0 113.0 113.0 114.0 113.0 115.0 114.0 114.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:108.50 stddev:16.13 (14.9%) stddev-sans-first:14.23 09:11:52 INFO - PROCESS | 1648 | Values: 143.0 108.0 108.0 143.0 105.0 108.0 107.0 109.0 136.0 108.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:182.40 Median:183.50 stddev:1.90 (1.0%) stddev-sans-first:1.92 09:11:52 INFO - PROCESS | 1648 | Values: 184.0 185.0 180.0 183.0 182.0 180.0 180.0 184.0 182.0 184.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:65.90 Median:68.00 stddev:11.83 (17.4%) stddev-sans-first:11.21 09:11:52 INFO - PROCESS | 1648 | Values: 81.0 57.0 57.0 86.0 59.0 67.0 54.0 69.0 76.0 53.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:76.50 stddev:10.56 (13.8%) stddev-sans-first:10.92 09:11:52 INFO - PROCESS | 1648 | Values: 83.0 69.0 92.0 68.0 67.0 69.0 88.0 67.0 70.0 90.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:86.00 stddev:1.81 (2.1%) stddev-sans-first:1.74 09:11:52 INFO - PROCESS | 1648 | Values: 88.0 84.0 86.0 85.0 86.0 85.0 89.0 85.0 87.0 83.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:102.20 Median:93.00 stddev:18.71 (20.1%) stddev-sans-first:19.47 09:11:52 INFO - PROCESS | 1648 | Values: 92.0 92.0 93.0 106.0 150.0 117.0 93.0 93.0 93.0 93.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:82.10 Median:83.00 stddev:1.10 (1.3%) stddev-sans-first:1.09 09:11:52 INFO - PROCESS | 1648 | Values: 81.0 82.0 82.0 81.0 83.0 83.0 83.0 83.0 83.0 80.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:55.50 stddev:2.71 (4.9%) stddev-sans-first:2.69 09:11:52 INFO - PROCESS | 1648 | Values: 51.0 50.0 50.0 52.0 56.0 56.0 57.0 56.0 54.0 55.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:75.20 Median:73.00 stddev:12.44 (17.0%) stddev-sans-first:12.39 09:11:52 INFO - PROCESS | 1648 | Values: 63.0 68.0 73.0 73.0 74.0 98.0 98.0 69.0 68.0 68.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:1.43 (1.7%) stddev-sans-first:1.51 09:11:52 INFO - PROCESS | 1648 | Values: 82.0 82.0 83.0 82.0 82.0 82.0 81.0 83.0 81.0 86.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:152.00 stddev:25.67 (16.9%) stddev-sans-first:26.48 09:11:52 INFO - PROCESS | 1648 | Values: 135.0 136.0 135.0 156.0 153.0 151.0 139.0 140.0 221.0 154.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 09:11:52 INFO - PROCESS | 1648 | Values: 161.0 161.0 161.0 161.0 162.0 161.0 161.0 160.0 161.0 161.0 09:11:52 INFO - PROCESS | 1648 | 09:11:52 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 09:11:52 INFO - PROCESS | 1648 | Values: 66.0 66.0 68.0 67.0 67.0 65.0 65.0 66.0 65.0 65.0 09:11:52 INFO - PROCESS | 1648 | -------- Summary: end -------- 09:11:52 INFO - PROCESS | 1648 | 09:11:53 INFO - TEST-INFO | 1648: exit 0 09:11:53 INFO - TEST-OK | kraken | took 58644ms 09:11:53 INFO - SUITE-END | took 1176s 09:11:53 INFO - Completed test suite (00:19:36) 09:11:53 INFO - javascript benchmark 09:11:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2941.764658827294, 3471.0, 3527.982360088199, 3536.169000284933, 3599.0102721751514, 5964.075568286911, 5965.284165900092, 5967.582269241155, 5972.19375384323, 5993.43062409071, 5646.378898321192, 5942.851428714273, 5966.5226781857455, 5976.103584462322, 5985.850353741159, 5284.180951952444, 5289.365276166846, 5305.920411193835, 5351.545118664918, 5363.785448582052, 5255.316808814849, 5260.710660913648, 5276.023935571912, 5382.381026181981, 5436.429174936634, 4470.8882277942985, 5336.17289320156, 5344.625876188668, 5350.598705097113, 5354.759035843396, 5358.383785864637, 5362.544183744387, 5369.140937449989, 5370.087085195487, 5373.677579345252, 5167.199084141964, 5296.602754793406, 5299.4700529946695, 5302.840914772563, 5308.0710875596615, 5992.520598352121, 6035.185249991239, 6058.303295121029, 6090.086487026937, 6109.266887973427, 6172.600330834698, 6211.130441738161, 6217.56477046607, 6224.128621992924, 6242.438180563771, 6120.264288666148, 6167.44492995628, 6195.87608247837, 6315.336889626569, 6337.081123237151, 5932.377100404438, 5988.221531201003, 5995.730192141364, 5996.190514280604, 5997.0, 6359.682015899187, 6377.585456945377, 6391.009393544008, 6391.392817682406, 6408.10286559882, 6112.420797151262, 6145.477634401037, 6187.597806142587, 6309.0, 6320.494360451153, 6231.906521402183, 6242.500599951993, 6246.6876656167005, 6248.343923887926, 6269.435750782452, 6282.057691346243, 6287.339829317947, 6289.339619339903, 6290.8427289317215, 6319.46284565817, 6177.907331390033, 6180.907286390708, 6214.347493513206, 6244.531660125509, 6254.3745625438005, 5022.447530771612, 5025.3718285214345, 5032.84901452957, 5039.118154322979, 5042.596592272609, 3828.1769419574925, 4505.6846020778885, 4573.5426457354, 4574.4510658721165, 4587.79354929029, 5956.791512297049, 6053.092036194606, 6076.3316035236085, 6084.60450070744, 6092.268927728701, 6261.186045814015, 6275.215598050244, 6281.8743625127245, 6283.08895210192, 6286.371362863677, 5853.912191317134, 5930.258717660293, 5933.881322373529, 5991.910121348184, 6002.279726432856, 5538.086215774352, 5538.556915446755, 5544.0, 5551.000819852466, 5551.084071128299, 6253.906191407133, 6277.403646653744, 6298.622082675054, 6311.810645680637, 6324.209473815773, 6192.566520343533, 6246.281677607133, 6261.279952805486, 6264.123022776724, 6267.373262673696, 6420.903686444613, 6426.100345951664, 6431.935680643133, 6435.002574600944, 6444.871102578016, 6080.604760690541, 6162.661053641913, 6224.533160012927, 6242.157308763259, 6252.781152659635, 6165.815025549241, 6189.876202475835, 6224.1597384352535, 6246.5002799775, 6247.375262473716, 6153.0, 6278.529110316653, 6288.496920246278, 6302.621842689453, 6318.652474113968, 4900.0, 6255.24937007562, 6267.185265915402, 6278.121063051085, 6287.245530536365, 6030.185924900083, 6102.572819902742, 6121.693915304306, 6135.44703110649, 6140.293866205444, 6290.21372328459, 6293.653849038347, 6295.3389894060465, 6295.905561416491, 6306.337834527309, 6218.968905155445, 6222.502199823913, 6229.53278504123, 6240.594361366497, 6250.4374606285655], "value": 5810.270307091282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.76488902882096, 527.9868003299919, 529.2326127115682, 551.8068675963414, 559.4824787071963, 30876.84561577192, 32780.34439311215, 32784.836075819614, 38364.42453363195, 39870.8006459968, 43497.565024349744, 43707.0, 43737.56262437375, 43883.0, 44024.779876100576, 9604.951975240114, 9790.755231119243, 9809.117179453848, 9818.312718109735, 9823.50882455878, 8942.687005954793, 9157.038510956354, 9600.087991640783, 9702.66040688576, 11611.129165312635, 11671.1830171888, 11979.460924258387, 11988.760224795498, 12003.459844306983, 12011.27932324059, 11910.702232444171, 11939.34333611651, 11948.402579871059, 11962.940185299018, 11964.40177991097, 11739.765204695857, 11749.882501174965, 11779.941100294529, 11802.11484138693, 11825.231359961661, 40186.39720404196, 40441.59558404437, 40490.0, 40492.797536012426, 40559.594404055875, 3412.3004784019217, 3591.4434457152506, 3654.9948764089822, 3958.386450100239, 4063.471748672683, 29391.85304073466, 29638.55542166869, 29749.0, 30027.69972300271, 32014.839925800454, 3197.6322722886935, 3268.3953468608383, 3285.0965984354257, 3358.0, 3403.5405220295193, 501551.0, 501850.0, 504403.0, 657062.0, 657893.0, 34273.14317142092, 34836.651633483845, 60085.0, 60736.69631651902, 60813.783724325265, 36366.63633363685, 36425.453618195745, 36520.904372868856, 36577.0, 36621.450678239846, 13234.205947643171, 14926.179060151579, 15100.697986040217, 15270.007449515746, 15394.307256173499, 12844.422001009976, 12954.028447866447, 12957.481700731865, 13003.609891703263, 13015.0, 7485.812854678677, 7654.808629784188, 7913.723019694398, 8161.224683655043, 8188.26305632484, 3337.499375093707, 3378.2567835076734, 3385.170633194834, 3393.236521782579, 3415.1291420688062, 975.380633297861, 1009.1573536097441, 1029.8506716526063, 1033.509083185496, 1052.8104941110673, 30201.09396718102, 30426.695733042387, 30518.62666179983, 30667.69332306693, 30948.40769725075, 1115.16919894679, 1140.9372484513265, 1163.040491594438, 1168.661088284388, 1209.9516019359303, 15589.0, 15789.36842526309, 15856.920715396349, 15892.602684932737, 16254.349826007065, 691676.0, 697146.0, 698031.0, 698786.0, 699624.0, 59526.40473595295, 59996.400035999955, 60148.09777853336, 60236.0, 60477.69761151254, 1273.0961017677369, 1325.1651459580403, 1397.5946975377026, 1428.350100704177, 1452.0924422236103, 30210.54684179695, 30407.847960760053, 30933.690663093083, 31367.05898823039, 31636.36727265396, 43857.903552411444, 46760.0, 48954.75522622364, 49483.0, 49577.75211123921, 463539.0, 465058.0, 467972.0, 468902.0, 804317.0, 26530.336741581614, 27233.72766272391, 27272.909083636434, 27888.44223115486, 27890.581641275803, 46524.767376162905, 47138.0, 47199.52800471951, 47624.523754762005, 47784.761076194394, 38771.41842872416, 39503.80248098741, 39603.811885643474, 39775.0, 41074.79462602788, 39165.82502524929, 39302.0, 39774.40338394869, 40264.0, 40608.39087413632, 37994.81002594969, 38363.23273534569, 39010.0, 39240.82277531679, 39554.40668390034, 32808.34383312368, 33984.8905134933, 34295.828520857234, 34540.481892771124, 34718.65281347154, 25604.743952560235, 25856.353591160372, 25969.091081812046, 26141.73858261393, 26420.867895660398], "value": 19300.308152990143, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.59730789401385, 386.40107832859064, 389.2740039825726, 399.1577770903393, 406.42085028833907, 19288.3249086282, 21077.894610526924, 21577.4605634859, 21806.781932180675, 22132.778672213273, 17556.297748090063, 20786.792132078674, 21198.89400552999, 21722.239721609745, 21764.45588860279, 5978.192943952576, 6063.484603808682, 6188.381161883821, 6248.125262463259, 6253.749850005995, 4416.668749843759, 4649.232876575378, 6120.26556813183, 6224.0, 6224.346443623423, 5442.673439593617, 6826.897596536056, 6878.793636190922, 6957.6521173941355, 6977.9302206978045, 6628.270890202074, 6870.484713646471, 6917.7578784742545, 6918.619475928822, 6940.271271516519, 5981.671008094553, 6029.8191054268445, 6056.182415373913, 6077.483413909823, 6120.693965301717, 26368.20895373142, 26519.76668826949, 26714.0, 27253.0, 27418.725812741817, 2004.6992951057457, 2460.335709358481, 2489.35276828026, 2500.5124000819847, 2506.94986100277, 16327.428540001043, 16568.502944911674, 16709.415170468976, 16794.916025419796, 17118.828811711846, 1791.8208179182109, 1884.896330701811, 1949.9025048747505, 1955.6284305981817, 1984.3848406993877, 107456.0, 108664.91335086626, 111264.0, 114758.99999999917, 115766.0, 11535.538578456768, 11564.074874010059, 11690.532378704927, 11713.0, 11857.822132668018, 15210.0, 15247.390104395921, 15249.085054896519, 15278.31247593861, 15287.770683439758, 6221.844453888689, 6393.744250229939, 8837.337199710048, 8849.0, 8970.596323165473, 8744.0, 8749.693760718344, 8752.606132724042, 8896.110388961182, 8936.882889638795, 4621.468531118964, 4703.976480117578, 4716.3632909557455, 4729.219678753036, 4762.904741905212, 1811.8459930905758, 1841.0142042478153, 1960.2061165228106, 2002.8497862660358, 2003.7294965179806, 818.9467684600481, 963.5904740485265, 990.7325022243954, 991.3902949685892, 1013.7972405518778, 20870.0, 22167.77832221657, 22247.888760556092, 22266.0, 22267.777322226895, 934.0939288889766, 971.2230215827451, 972.7665360313474, 994.6121012805012, 1008.1884083313004, 9051.823262975771, 10344.0, 11735.119866010084, 11816.172867899164, 11844.644660660195, 602758.0, 603313.98343008, 608841.9557902182, 617442.0, 617892.0, 122180.38909805572, 123558.0, 126605.0, 127319.0, 131277.0, 852.6291063387446, 962.4225464721111, 983.1839573154265, 1004.1866088468219, 1006.2000709436016, 16714.832851671326, 17557.561060973578, 19497.0, 19568.0, 19628.0, 49961.75019124881, 51426.0, 52491.47508525019, 53274.0, 53643.0, 72312.0, 74407.25592744003, 75182.24817751753, 75885.620571899, 75991.0, 8040.839183216186, 8207.466514676527, 8293.0, 8398.496090234605, 8405.747827565183, 8817.867731983897, 12609.87390126087, 12726.300053497147, 13051.608451746462, 13187.67030824237, 10134.949325253327, 10264.973502649975, 10997.780044399227, 11179.944100279447, 11459.828102578635, 10993.450327483753, 11073.50169242402, 11195.776084478428, 11203.428328244629, 11337.659870203906, 9612.327137100336, 10434.321769084985, 10725.105636610037, 11451.828222576834, 11581.42092895335, 8145.144759800136, 8456.238938495564, 11734.765304694029, 12038.337891416057, 12653.74692506163, 10684.0, 11795.646130615753, 11825.82261266099, 11906.285622862655, 11942.701432464259], "value": 9934.602863827598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.2212060788695, 1532.348751780493, 1737.4005967941057, 1891.527118220445, 1915.770107587089, 7252.2747725227455, 8095.352371810256, 8520.105388934158, 8520.318374530038, 8525.786855328612, 7483.401327893769, 7739.690412383512, 7742.767716968486, 7834.72578459754, 7847.293743563093, 2159.773223811497, 2317.5480781247666, 2386.677798497198, 2393.6888204533475, 2407.325948734357, 2404.1488054198257, 2421.9757802422014, 2433.2092070077297, 2433.5376278507115, 2438.036975394718, 2379.310000099969, 2403.663487111806, 2406.74729153439, 2408.0247499762536, 2415.6255780353986, 2346.730126035502, 2378.9048438062455, 2383.9046438142454, 2384.9046038158453, 2386.940326491834, 2386.0813586769045, 2392.653065305521, 2412.3124909400735, 2414.517096580691, 2417.033186725324, 8265.669373225124, 8417.410781245315, 8426.536540490271, 8448.0, 8510.957445212796, 5075.898482030376, 5233.4243233244315, 5236.240745091978, 5248.685078895279, 5248.790048398059, 2969.717876801722, 3320.452125399306, 3492.0, 3559.501669766209, 3566.35805555, 1022.1771473963456, 1062.697131317571, 1087.065123993365, 1095.956161753537, 1099.5272033025797, 10817.0, 10827.783444331148, 10835.970582794622, 10847.45762711869, 10877.347359158475, 4508.436445444319, 4734.692245004064, 4795.544423279783, 4799.448063472675, 4809.639277054235, 9466.952665236768, 9479.573419196153, 9494.905050949541, 9502.0, 9538.0, 5244.737763111829, 5245.239440281214, 5246.947530524722, 5250.343707036621, 5260.710660913686, 4414.558544145624, 4595.885102872455, 4767.809287628525, 4788.401449818773, 4861.319415281863, 3614.4216925291826, 3729.272791805572, 3739.289534988398, 3740.7194460415576, 3746.550413950343, 1030.7732298894232, 1273.6943133647858, 1298.461138627478, 1303.5828534868751, 1305.106002388367, 855.7347222361088, 857.3012994409536, 871.9825603487894, 892.1881088209827, 895.9964839379936, 5112.948870511322, 5717.628354156966, 5794.478496935296, 5982.820515384546, 6059.030555111161, 954.9331546791797, 969.6363863551169, 974.171953839231, 984.532347135105, 1000.8798944126752, 3525.506429099928, 3527.365074286653, 3555.839987200582, 3677.896631010686, 3710.888673339804, 9679.903200968041, 10097.394156350643, 10114.59541618327, 10127.898721012696, 10127.898721012843, 7429.62851857405, 9981.950090249502, 9993.750156246151, 9994.800103997879, 10008.899911000943, 7627.5042122261875, 7890.171531989288, 7902.960485197652, 7908.130105688369, 7918.881216781753, 5708.343540492897, 5732.971335143297, 5736.282964629421, 5830.5044071254415, 5913.02435098204, 9424.528773561431, 9427.24582033422, 9431.386959847589, 9434.716958491255, 9451.763705907408, 9338.39300445496, 9443.338966272295, 9567.37812042215, 9650.372725772802, 9691.563879625293, 7062.964685176747, 7184.856302873809, 7262.491625586158, 7275.054242948383, 7312.817179570553, 7164.140303163654, 7411.666475008746, 7761.107472640719, 7841.255080767318, 7857.724979625686, 6801.659917004031, 7044.542104763174, 7177.533460325062, 7189.245129261352, 7197.424206063607, 6996.265392133752, 6996.510244282851, 7020.227774944854, 7046.718131274692, 7133.785986420416, 6631.303713110054, 6735.898961515679, 6745.190577130776, 6767.593944363354, 6768.289329620319, 4787.712737235777, 4788.6662570373865, 4902.3872015998, 4925.408950925912, 5032.018756342624, 4795.424549053996, 4876.097921884321, 4905.0, 4987.12725273083, 4990.126727822689], "value": 4453.441515070592, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.222333000997, 312.5218415823789, 315.49993260681816, 325.2681466699925, 328.86516528223433, 4990.800367985281, 5044.26858105575, 5166.302549155863, 5306.602004849642, 5450.465533526904, 5132.5124113209185, 5252.789888404469, 5265.842024739254, 5351.491608297215, 5395.865103372417, 4132.8140233689555, 4148.191102734968, 4151.771652559108, 4162.916741665173, 4171.207470580595, 3762.454444105603, 3855.575886652466, 4047.575004624516, 4122.484689413824, 4135.958640413603, 3707.480952666629, 4049.412835138903, 4052.371882358239, 4066.6949978751713, 4072.450219220412, 4026.2551427985622, 4031.8588849390276, 4032.9395059074136, 4063.634272915422, 4079.4084857695466, 3021.773366997462, 3375.662433756629, 3476.3394954958476, 3497.4054410749977, 3572.7677700949357, 4387.802548885308, 5061.696298222082, 5221.702450921621, 5247.47525247476, 5249.4750524947585, 4067.9186416271805, 4239.58343744066, 4658.574354363334, 4669.369635099252, 4680.057776022946, 4909.091818013679, 4924.8276310328965, 4935.851924442272, 5388.491222457718, 5659.660420374749, 3582.462630605404, 3856.402257650069, 3893.6301051400073, 3897.57126716061, 3924.352481840493, 5437.9124175165125, 5570.220169176318, 5635.1828984797385, 5681.488666020078, 5948.345681974979, 3645.5807582128396, 3946.4869566956113, 3963.8612648557164, 3970.895425424472, 3981.2634662587516, 3860.7104467165077, 4002.479677641888, 4008.9198216035516, 4019.0, 4033.576474470197, 4597.287420449836, 4627.8611641650805, 4633.305004249322, 4633.49031606523, 4649.325847752057, 5657.971710141505, 5658.801941932013, 5663.575231857545, 5666.631668941505, 5695.234477312047, 1116.4473585575192, 1221.2428294457493, 1258.5469231076804, 1275.8071203424827, 1293.7412517496539, 737.5095561451575, 817.2644619842071, 860.5955201055494, 875.1773333066897, 878.5958459108881, 4182.811773470201, 4989.950100498949, 5002.849914502571, 5003.573266965519, 5009.5491405773655, 4473.888152796141, 5054.898902021939, 5450.781968721207, 5477.616566840363, 5542.667439953616, 4135.731177473454, 4234.449521562239, 4711.0, 4937.703737775673, 4964.776585053682, 2478.714947780992, 2580.354911272182, 2620.7379262074023, 2785.1505290886475, 2889.179816715498, 5213.765380557884, 5668.971655141698, 5680.488756011979, 5705.74324155414, 5708.40061793514, 4889.828855990023, 5309.33633295838, 5511.366192887789, 5597.3003374578175, 5631.521320687705, 5219.460259223614, 6024.096385542116, 6118.3269840317525, 6131.908021379683, 6150.661713605795, 5902.085176797603, 5909.320428150818, 5919.6744179070565, 5930.495907847881, 5950.434708702666, 5546.278983732089, 5801.970990145022, 5815.331236907809, 5833.0, 5842.561807864342, 6077.088436734525, 6083.66539840313, 6105.0, 6116.724747386289, 6147.280895058425, 3360.059183428644, 3783.319002579452, 3947.526296844397, 3981.8407263709128, 4128.298189307765, 4892.899097702988, 5746.270521502253, 5842.429331094305, 5892.261782774178, 5924.377940316377, 4261.062566235423, 4945.826896058621, 5651.943480565142, 5669.773209071756, 5705.62913410627, 5459.5632349412745, 5496.801279488077, 5509.5041446270025, 5680.6591604503865, 5786.396121745147, 4401.515833258403, 4928.605711542997, 4936.975315123402, 5504.889902201853, 5721.427857214246, 4977.8257760978195, 5602.803901863415, 5747.655140691572, 5781.364049954417, 5791.594588378773, 4789.3055506952, 5673.602847800615, 5675.177099320658, 5688.601797874109, 5730.455606717355], "value": 4076.1126102885714, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.6424259385122, 731.535474973392, 780.1184661332696, 834.1019766530791, 838.7232213369581, 14537.49118780843, 15680.059196448221, 15700.293486793093, 15722.371105155795, 15755.369785208592, 14019.789703154462, 14182.71634567308, 14188.07777494462, 14191.716165676706, 14199.14805111694, 698.2528694297079, 715.8818794898835, 722.68201991124, 724.8912663100524, 891.0376793063476, 716.6774951271923, 722.7795522365676, 859.188067276424, 887.525174031893, 895.082540396096, 950.410745337888, 960.2270172511126, 961.0821665309647, 965.030144704571, 967.4823969176492, 959.2421986630553, 960.5389413081759, 960.9231261499064, 961.4663861556833, 965.6861520005956, 713.5148099292479, 714.1287629092499, 715.0454143718142, 715.7101373943561, 718.3965469006008, 14508.0, 14524.927375363055, 14576.0, 14597.70804583913, 15095.773563396559, 13531.458741650322, 13988.460563653187, 14037.214015358471, 14127.223002734845, 14256.786148207786, 11191.440427978569, 11386.829197562043, 11511.0, 11680.532778688843, 11807.291562506278, 3733.1413774831667, 3907.7459965102175, 3911.3350730375905, 3957.8021098944937, 4021.7989100544855, 89159.0, 92799.0, 93327.60008599877, 94422.5278873608, 94866.0, 10820.78358432827, 10893.400862952614, 11109.333439993627, 11307.265027773168, 11690.240134391408, 21941.01265443059, 22101.778982209973, 22216.444588885082, 22269.66595501069, 22276.443088922584, 7833.167825223436, 7845.254700803414, 7852.254035866584, 7891.802704932308, 7936.2857342839425, 4216.409702641633, 4282.957170428318, 4360.520342762294, 4395.099004704028, 4405.669574781904, 3204.34310966256, 3281.950770738441, 3366.8316584170693, 3488.8255587220538, 3493.4235851084795, 612.761023200952, 620.8292719502173, 624.6814124796296, 647.6437959122558, 648.4002297874447, 653.859420224654, 655.131950166032, 674.5817593092314, 686.8111269400955, 690.3303795318533, 8523.505646635746, 9132.20559206422, 9183.816323673489, 9209.723708288762, 9278.536073196314, 641.1216633212529, 674.9021391898148, 678.7522554267657, 692.6917521702794, 697.5082566790401, 4418.8453404130705, 4432.202203603318, 4436.600705936481, 4486.910261794811, 4524.140413321458, 76373.0, 96869.0, 111310.44344778224, 114398.42800785943, 115529.0, 92426.0757392431, 97884.51057744665, 99888.0, 100071.99928000773, 100838.0, 81291.5935420331, 81678.0, 82021.17978820254, 82358.0, 84729.0, 8691.86962195555, 8756.868646970428, 8769.693060742844, 8875.600597973236, 8942.0, 50861.0, 51372.74313628557, 55082.72458637841, 55320.72339638276, 55810.0, 56911.0, 58258.0, 77400.2259977393, 79400.0, 82624.0, 11995.280283183038, 12975.0, 13050.608481745563, 13379.029582048068, 13458.865411345761, 14151.929240353733, 14513.05665131763, 14774.409023638935, 14776.187309698069, 14932.328045237773, 11409.20135590534, 12860.90543159576, 13837.962152838778, 13923.860761392256, 14338.283085845458, 13433.19400835953, 13689.772336062777, 13722.65693357674, 13747.656308591964, 13881.236531990837, 12851.485940562647, 13105.951523878257, 13189.670258243237, 13364.465421383036, 13384.531541396005, 10155.84766228522, 10754.516046777757, 10975.670729878117, 11170.72073198144, 11781.587644432404, 10806.18953578469, 11254.94372528132, 11547.422628868691, 11575.826362604399, 11610.361430121424], "value": 7494.914030145763, "unit": "score"}], "name": "dromaeo_css", "value": 7302.041497330042, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 115.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 108.0, 143.0, 105.0, 108.0, 107.0, 109.0, 136.0, 108.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 180.0, 183.0, 182.0, 180.0, 180.0, 184.0, 182.0, 184.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 57.0, 86.0, 59.0, 67.0, 54.0, 69.0, 76.0, 53.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 92.0, 68.0, 67.0, 69.0, 88.0, 67.0, 70.0, 90.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 86.0, 85.0, 86.0, 85.0, 89.0, 85.0, 87.0, 83.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 106.0, 150.0, 117.0, 93.0, 93.0, 93.0, 93.0], "value": 102.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 81.0, 83.0, 83.0, 83.0, 83.0, 83.0, 80.0], "value": 82.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 52.0, 56.0, 56.0, 57.0, 56.0, 54.0, 55.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 73.0, 73.0, 74.0, 98.0, 98.0, 69.0, 68.0, 68.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 82.0, 82.0, 82.0, 81.0, 83.0, 81.0, 86.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 136.0, 135.0, 156.0, 153.0, 151.0, 139.0, 140.0, 221.0, 154.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 160.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 67.0, 67.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1416.4, "alertThreshold": 2.0}]} 09:11:53 INFO - Return code: 0 09:11:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:11:53 INFO - # TBPL SUCCESS # 09:11:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:11:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:11:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:11:53 INFO - 2017-01-23 09:11:53.739 screenresolution[1652:10581] starting screenresolution argv=screenresolution get 09:11:53 INFO - 2017-01-23 09:11:53.743 screenresolution[1652:10581] Display 0: 1600x1200x32@60 09:11:53 INFO - 2017-01-23 09:11:53.749 screenresolution[1653:10584] starting screenresolution argv=screenresolution list 09:11:53 INFO - Available Modes on Display 0 09:11:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:11:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:11:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:11:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:11:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:11:53 INFO - Intel Iris: 09:11:53 INFO - Chipset Model: Intel Iris 09:11:53 INFO - Type: GPU 09:11:53 INFO - Bus: Built-In 09:11:53 INFO - VRAM (Dynamic, Max): 1536 MB 09:11:53 INFO - Vendor: Intel (0x8086) 09:11:53 INFO - Device ID: 0x0a2e 09:11:53 INFO - Revision ID: 0x0009 09:11:53 INFO - Displays: 09:11:53 INFO - Display: 09:11:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:11:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:11:53 INFO - Display Serial Number: 1600x1200 60 09:11:53 INFO - Main Display: Yes 09:11:53 INFO - Mirror: Off 09:11:53 INFO - Online: Yes 09:11:53 INFO - Rotation: Supported 09:11:53 INFO - Return code: 0 09:11:53 INFO - Running post-action listener: _resource_record_post_action 09:11:53 INFO - [mozharness: 2017-01-23 17:11:53.994108Z] Finished run-tests step (success) 09:11:53 INFO - Running post-run listener: _resource_record_post_run 09:11:54 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 37999616; Write bytes: 496195584; Read time: 246; Write time: 1576 09:11:54 INFO - TinderboxPrint: CPU usage
53.7% 09:11:54 INFO - TinderboxPrint: I/O read bytes / time
37,999,616 / 246 09:11:54 INFO - TinderboxPrint: I/O write bytes / time
496,195,584 / 1,576 09:11:54 INFO - TinderboxPrint: CPU idle
2,221.1 (46.3%) 09:11:54 INFO - TinderboxPrint: CPU system
962.8 (20.1%) 09:11:54 INFO - TinderboxPrint: CPU user
1,609.8 (33.6%) 09:11:54 INFO - TinderboxPrint: Swap in / out
229,105,664 / 0 09:11:54 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 180961792; Write bytes: 174424064; Read time: 17034; Write time: 372 09:11:54 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 37065728; Write bytes: 304048128; Read time: 233; Write time: 1147 09:11:54 INFO - Running post-run listener: _upload_blobber_files 09:11:54 INFO - Blob upload gear active. 09:11:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:11:54 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 09:11:54 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'] 09:11:54 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 09:11:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:11:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:56 INFO - (blobuploader) - INFO - Done attempting. 09:11:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:11:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:11:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:57 INFO - (blobuploader) - INFO - Done attempting. 09:11:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:11:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:11:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:59 INFO - (blobuploader) - INFO - Done attempting. 09:11:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:11:59 INFO - Return code: 0 09:11:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:11:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:11:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4028e1cc3e5a5d02a7e0e6208d76cc4135429f76c6cbad09e52ad42c613e520055e0bc0492ecdd6f0199c8e663d9a57da483ef65573b995593727c81750d5971", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e60f338c03d7b1f0098788a8cf0bd4fc57b69f5e04f61e15bab0888f5743b8999521cb4ee9df56980e9321825f1afbef9d80272c64003c1696d4bf615a983eb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9bea7998059312287d361202e0facd7fe915a776b28f80a20834ed26a92d869706b8c1543e81afe21dedb87dc30b75955647eef7ba35a93169e45243804c4a0"} 09:11:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:11:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:11:59 INFO - Contents: 09:11:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4028e1cc3e5a5d02a7e0e6208d76cc4135429f76c6cbad09e52ad42c613e520055e0bc0492ecdd6f0199c8e663d9a57da483ef65573b995593727c81750d5971", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e60f338c03d7b1f0098788a8cf0bd4fc57b69f5e04f61e15bab0888f5743b8999521cb4ee9df56980e9321825f1afbef9d80272c64003c1696d4bf615a983eb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9bea7998059312287d361202e0facd7fe915a776b28f80a20834ed26a92d869706b8c1543e81afe21dedb87dc30b75955647eef7ba35a93169e45243804c4a0"} 09:11:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:11:59 INFO - Copying logs to upload dir... 09:11:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:11:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.861561 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-23 09:11:59.562298) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 09:11:59.567705) ========= 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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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/4028e1cc3e5a5d02a7e0e6208d76cc4135429f76c6cbad09e52ad42c613e520055e0bc0492ecdd6f0199c8e663d9a57da483ef65573b995593727c81750d5971", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e60f338c03d7b1f0098788a8cf0bd4fc57b69f5e04f61e15bab0888f5743b8999521cb4ee9df56980e9321825f1afbef9d80272c64003c1696d4bf615a983eb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9bea7998059312287d361202e0facd7fe915a776b28f80a20834ed26a92d869706b8c1543e81afe21dedb87dc30b75955647eef7ba35a93169e45243804c4a0"} build_url:https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011072 build_url: 'https://queue.taskcluster.net/v1/task/Jrec1B1JS5623ntOt2D0mA/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/4028e1cc3e5a5d02a7e0e6208d76cc4135429f76c6cbad09e52ad42c613e520055e0bc0492ecdd6f0199c8e663d9a57da483ef65573b995593727c81750d5971", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e60f338c03d7b1f0098788a8cf0bd4fc57b69f5e04f61e15bab0888f5743b8999521cb4ee9df56980e9321825f1afbef9d80272c64003c1696d4bf615a983eb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e9bea7998059312287d361202e0facd7fe915a776b28f80a20834ed26a92d869706b8c1543e81afe21dedb87dc30b75955647eef7ba35a93169e45243804c4a0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 09:11:59.601516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:11:59.601811) ========= 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.8kNOlchaOC/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.Fe1oLN0jyY/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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.005085 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:11:59.649801) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 09:11:59.650083) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 09:11:59.653366) ========= ========= Total master_lag: 0.18 =========