builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0357 starttime: 1491332200.23 results: success (0) buildid: 20170404110128 builduid: 960b9116f8ff49ca8ff5054bc24ac4e0 revision: 6e2ce3dd9d87e587a66426931f5146b7e73db3d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 11:56:40.227499) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 11:56:40.227971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 11:56:40.228247) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 11:56:40.255188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 11:56:40.255601) ========= 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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-04 11:56:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.2M=0.001s 2017-04-04 11:56:40 (19.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 11:56:40.426484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 11:56:40.426801) ========= 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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.026282 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 11:56:40.476025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-04 11:56:40.476471) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6e2ce3dd9d87e587a66426931f5146b7e73db3d0 --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 6e2ce3dd9d87e587a66426931f5146b7e73db3d0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HL9mdDi3BN/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.aIz5OlGAyM/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-04 11:56:40,585 truncating revision to first 12 chars 2017-04-04 11:56:40,586 Setting DEBUG logging. 2017-04-04 11:56:40,586 attempt 1/10 2017-04-04 11:56:40,586 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6e2ce3dd9d87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 11:56:42,314 unpacking tar archive at: mozilla-beta-6e2ce3dd9d87/testing/mozharness/ program finished with exit code 0 elapsedTime=2.005209 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-04 11:56:42.594447) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 11:56:42.594782) ========= script_repo_revision: 6e2ce3dd9d87e587a66426931f5146b7e73db3d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 11:56:42.595179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 11:56:42.595460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 11:56:42.621103) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-04-04 11:56:42.621507) ========= /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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 11:56:42 INFO - MultiFileLogger online at 20170404 11:56:42 in /builds/slave/test 11:56:42 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 11:56:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:56:42 INFO - {'append_to_log': False, 11:56:42 INFO - 'base_work_dir': '/builds/slave/test', 11:56:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:56:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:56:42 INFO - 'branch': 'Mozilla-Beta', 11:56:42 INFO - 'buildbot_json_path': 'buildprops.json', 11:56:42 INFO - 'config_files': ('talos/mac_config.py',), 11:56:42 INFO - 'default_actions': ('clobber', 11:56:42 INFO - 'read-buildbot-config', 11:56:42 INFO - 'download-and-extract', 11:56:42 INFO - 'populate-webroot', 11:56:42 INFO - 'create-virtualenv', 11:56:42 INFO - 'install', 11:56:42 INFO - 'run-tests'), 11:56:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:56:42 INFO - 'download_minidump_stackwalk': True, 11:56:42 INFO - 'download_symbols': 'ondemand', 11:56:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:56:42 INFO - 'tooltool.py': '/tools/tooltool.py', 11:56:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:56:42 INFO - '/tools/misc-python/virtualenv.py')}, 11:56:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:56:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:56:42 INFO - 'installer_path': 'installer.exe', 11:56:42 INFO - 'log_level': 'info', 11:56:42 INFO - 'log_name': 'talos', 11:56:42 INFO - 'log_to_console': True, 11:56:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:56:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:56:42 INFO - 'opt_config_files': (), 11:56:42 INFO - 'pip_index': False, 11:56:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:56:42 INFO - 'cmd': ('bash', 11:56:42 INFO - '-c', 11:56:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:56:42 INFO - 'enabled': True, 11:56:42 INFO - 'halt_on_failure': False, 11:56:42 INFO - 'name': 'check_screen_resolution'},), 11:56:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:56:42 INFO - 'cmd': ('bash', 11:56:42 INFO - '-c', 11:56:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:56:42 INFO - 'enabled': True, 11:56:42 INFO - 'halt_on_failure': False, 11:56:42 INFO - 'name': 'check_screen_resolution'},), 11:56:42 INFO - 'run_cmd_checks_enabled': True, 11:56:42 INFO - 'sps_profile': False, 11:56:42 INFO - 'sps_profile_interval': 0, 11:56:42 INFO - 'suite': 'dromaeojs', 11:56:42 INFO - 'system_bits': '32', 11:56:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:56:42 INFO - 'title': 't-yosemite-r7-0357', 11:56:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:56:42 INFO - 'use_talos_json': True, 11:56:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:56:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:56:42 INFO - 'work_dir': 'build'} 11:56:42 INFO - [mozharness: 2017-04-04 18:56:42.834978Z] Running clobber step. 11:56:42 INFO - Running pre-action listener: _resource_record_pre_action 11:56:42 INFO - Running main action method: clobber 11:56:42 INFO - rmtree: /builds/slave/test/build 11:56:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:56:45 INFO - Running post-action listener: _resource_record_post_action 11:56:45 INFO - [mozharness: 2017-04-04 18:56:45.231351Z] Finished clobber step (success) 11:56:45 INFO - [mozharness: 2017-04-04 18:56:45.231536Z] Running read-buildbot-config step. 11:56:45 INFO - Running pre-action listener: _resource_record_pre_action 11:56:45 INFO - Running main action method: read_buildbot_config 11:56:45 INFO - Using buildbot properties: 11:56:45 INFO - { 11:56:45 INFO - "project": "", 11:56:45 INFO - "product": "firefox", 11:56:45 INFO - "script_repo_revision": "production", 11:56:45 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:56:45 INFO - "repository": "", 11:56:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:56:45 INFO - "buildid": "20170404110128", 11:56:45 INFO - "pgo_build": "False", 11:56:45 INFO - "basedir": "/builds/slave/test", 11:56:45 INFO - "buildnumber": 16, 11:56:45 INFO - "slavename": "t-yosemite-r7-0357", 11:56:45 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:56:45 INFO - "platform": "yosemite_r7", 11:56:45 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:56:45 INFO - "branch": "mozilla-beta", 11:56:45 INFO - "repo_path": "releases/mozilla-beta", 11:56:45 INFO - "revision": "6e2ce3dd9d87e587a66426931f5146b7e73db3d0", 11:56:45 INFO - "stage_platform": "macosx64", 11:56:45 INFO - "builduid": "960b9116f8ff49ca8ff5054bc24ac4e0", 11:56:45 INFO - "slavebuilddir": "test" 11:56:45 INFO - } 11:56:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 11:56:45 INFO - Running post-action listener: _resource_record_post_action 11:56:45 INFO - [mozharness: 2017-04-04 18:56:45.234981Z] Finished read-buildbot-config step (success) 11:56:45 INFO - [mozharness: 2017-04-04 18:56:45.235094Z] Running download-and-extract step. 11:56:45 INFO - Running pre-action listener: _resource_record_pre_action 11:56:45 INFO - Running main action method: download_and_extract 11:56:45 INFO - mkdir: /builds/slave/test/build/tests 11:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:45 INFO - trying https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 11:56:45 INFO - Downloading https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 11:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 11:56:46 INFO - Downloaded 1165 bytes. 11:56:46 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 11:56:46 INFO - Using the following test package requirements: 11:56:46 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 11:56:46 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:56:46 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 11:56:46 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:56:46 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 11:56:46 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:56:46 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:56:46 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 11:56:46 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 11:56:46 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:56:46 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 11:56:46 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:56:46 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 11:56:46 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:56:46 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 11:56:46 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:56:46 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 11:56:46 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 11:56:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 11:56:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 11:56:46 INFO - Fetch https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 11:56:47 INFO - Expected file size: 16116742 11:56:47 INFO - Obtained file size: 16116742 11:56:54 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:56:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 11:56:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 11:56:54 INFO - Fetch https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 11:56:54 INFO - Expected file size: 16116742 11:56:54 INFO - Obtained file size: 16116742 11:57:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 11:57:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 11:57:01 INFO - Fetch https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 11:57:02 INFO - Expected file size: 14403663 11:57:02 INFO - Obtained file size: 14403663 11:57:02 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')]} 11:57:02 INFO - trying https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 11:57:02 INFO - Downloading https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 11:57:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 11:57:04 INFO - Downloaded 58740248 bytes. 11:57:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 11:57:04 INFO - mkdir: /builds/slave/test/properties 11:57:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:57:04 INFO - Writing to file /builds/slave/test/properties/build_url 11:57:04 INFO - Contents: 11:57:04 INFO - build_url:https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 11:57:05 INFO - Running post-action listener: _resource_record_post_action 11:57:05 INFO - Running post-action listener: set_extra_try_arguments 11:57:05 INFO - [mozharness: 2017-04-04 18:57:05.170898Z] Finished download-and-extract step (success) 11:57:05 INFO - [mozharness: 2017-04-04 18:57:05.171055Z] Running populate-webroot step. 11:57:05 INFO - Running pre-action listener: _resource_record_pre_action 11:57:05 INFO - Running main action method: populate_webroot 11:57:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:57:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:57:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:57:05 INFO - '--tppagecycles', 11:57:05 INFO - '7'], 11:57:05 INFO - 'tests': ['tsvgm']}}, 11:57:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:57:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:57:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:57:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:57:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:57:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:57:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:57:05 INFO - 'talos_options': ['--disable-e10s'], 11:57:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:57:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:57:05 INFO - 'talos_options': ['--disable-e10s'], 11:57:05 INFO - 'tests': ['damp', 'tps']}, 11:57:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:57:05 INFO - 'tests': ['damp', 'tps']}, 11:57:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:57:05 INFO - 'tests': ['dromaeo_dom']}, 11:57:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:57:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:57:05 INFO - 'tests': ['basic_compositor_video']}, 11:57:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:57:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:57:05 INFO - 'tests': ['a11yr', 11:57:05 INFO - 'ts_paint', 11:57:05 INFO - 'tpaint', 11:57:05 INFO - 'sessionrestore', 11:57:05 INFO - 'sessionrestore_no_auto_restore', 11:57:05 INFO - 'tabpaint']}, 11:57:05 INFO - 'other-e10s': {'tests': ['a11yr', 11:57:05 INFO - 'ts_paint', 11:57:05 INFO - 'tpaint', 11:57:05 INFO - 'sessionrestore', 11:57:05 INFO - 'sessionrestore_no_auto_restore', 11:57:05 INFO - 'tabpaint']}, 11:57:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:57:05 INFO - 'ts_paint', 11:57:05 INFO - 'tpaint', 11:57:05 INFO - 'sessionrestore', 11:57:05 INFO - 'sessionrestore_no_auto_restore', 11:57:05 INFO - 'tabpaint']}, 11:57:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:57:05 INFO - 'ts_paint', 11:57:05 INFO - 'tpaint', 11:57:05 INFO - 'sessionrestore', 11:57:05 INFO - 'sessionrestore_no_auto_restore', 11:57:05 INFO - 'tabpaint']}, 11:57:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:57:05 INFO - 'tests': ['a11yr', 11:57:05 INFO - 'ts_paint', 11:57:05 INFO - 'tpaint', 11:57:05 INFO - 'sessionrestore', 11:57:05 INFO - 'sessionrestore_no_auto_restore', 11:57:05 INFO - 'tabpaint']}, 11:57:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:57:05 INFO - 'tests': ['a11yr', 11:57:05 INFO - 'ts_paint', 11:57:05 INFO - 'tpaint', 11:57:05 INFO - 'sessionrestore', 11:57:05 INFO - 'sessionrestore_no_auto_restore', 11:57:05 INFO - 'tabpaint']}, 11:57:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:57:05 INFO - 'tests': ['tsvgx', 11:57:05 INFO - 'tsvgr_opacity', 11:57:05 INFO - 'tart', 11:57:05 INFO - 'tscrollx', 11:57:05 INFO - 'cart', 11:57:05 INFO - 'tsvg_static']}, 11:57:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:57:05 INFO - 'tsvgr_opacity', 11:57:05 INFO - 'tart', 11:57:05 INFO - 'tscrollx', 11:57:05 INFO - 'cart', 11:57:05 INFO - 'tsvg_static']}, 11:57:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:57:05 INFO - 'talos_options': ['--disable-e10s'], 11:57:05 INFO - 'tests': ['tp5o']}, 11:57:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:57:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:57:05 INFO - 'talos_options': ['--disable-e10s', 11:57:05 INFO - '--xperf_path', 11:57:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:05 INFO - 'tests': ['tp5n']}, 11:57:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:57:05 INFO - 'talos_options': ['--xperf_path', 11:57:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:05 INFO - 'tests': ['tp5n']}}, 11:57:05 INFO - 'talos.zip': {'path': '', 11:57:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:57:05 INFO - Running post-action listener: _resource_record_post_action 11:57:05 INFO - [mozharness: 2017-04-04 18:57:05.190046Z] Finished populate-webroot step (success) 11:57:05 INFO - [mozharness: 2017-04-04 18:57:05.190183Z] Running create-virtualenv step. 11:57:05 INFO - Running pre-action listener: _resource_record_pre_action 11:57:05 INFO - Running main action method: create_virtualenv 11:57:05 INFO - Creating virtualenv /builds/slave/test/build/venv 11:57:05 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 11:57:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:57:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:57:05 INFO - Using real prefix '/tools/python27' 11:57:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:57:06 INFO - Installing distribute.............................................................................................................................................................................................done. 11:57:08 INFO - Installing pip.................done. 11:57:08 INFO - Return code: 0 11:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:57:09 INFO - Reading from file tmpfile_stdout 11:57:09 INFO - Output received: 11:57:09 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) 11:57:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:09 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 0x102c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb602de18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ffd30>, '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 0x102926db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f4be8>, '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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 11:57:09 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 11:57:09 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 11:57:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HL9mdDi3BN/Render', 11:57:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:09 INFO - 'HOME': '/Users/cltbld', 11:57:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:09 INFO - 'LOGNAME': 'cltbld', 11:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:09 INFO - 'MOZ_NO_REMOTE': '1', 11:57:09 INFO - 'NO_EM_RESTART': '1', 11:57:09 INFO - 'PAGER': '/bin/cat', 11:57:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:09 INFO - 'PWD': '/builds/slave/test', 11:57:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:09 INFO - 'SHELL': '/bin/bash', 11:57:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aIz5OlGAyM/Listeners', 11:57:09 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 11:57:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:09 INFO - 'USER': 'cltbld', 11:57:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:09 INFO - 'XPC_FLAGS': '0x0', 11:57:09 INFO - 'XPC_SERVICE_NAME': '0', 11:57:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:09 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 11:57:09 INFO - Cleaning up... 11:57:09 INFO - Return code: 0 11:57:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:09 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 0x102c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb602de18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ffd30>, '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 0x102926db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f4be8>, '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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 11:57:09 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 11:57:09 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 11:57:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HL9mdDi3BN/Render', 11:57:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:09 INFO - 'HOME': '/Users/cltbld', 11:57:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:09 INFO - 'LOGNAME': 'cltbld', 11:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:09 INFO - 'MOZ_NO_REMOTE': '1', 11:57:09 INFO - 'NO_EM_RESTART': '1', 11:57:09 INFO - 'PAGER': '/bin/cat', 11:57:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:09 INFO - 'PWD': '/builds/slave/test', 11:57:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:09 INFO - 'SHELL': '/bin/bash', 11:57:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aIz5OlGAyM/Listeners', 11:57:09 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 11:57:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:09 INFO - 'USER': 'cltbld', 11:57:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:09 INFO - 'XPC_FLAGS': '0x0', 11:57:09 INFO - 'XPC_SERVICE_NAME': '0', 11:57:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:09 INFO - Downloading/unpacking psutil>=3.1.1 11:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:57:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:57:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:57:13 INFO - Installing collected packages: psutil 11:57:13 INFO - Running setup.py install for psutil 11:57:13 INFO - building 'psutil._psutil_osx' extension 11:57:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:57:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:57:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:57:14 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 11:57:14 INFO - building 'psutil._psutil_posix' extension 11:57:14 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 11:57:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:57:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:57:14 INFO - ^ 11:57:14 INFO - 1 warning generated. 11:57:14 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 11:57:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:57:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:57:14 INFO - Successfully installed psutil 11:57:14 INFO - Cleaning up... 11:57:14 INFO - Return code: 0 11:57:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:57:14 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')]} 11:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:14 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')]} 11:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:14 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 0x102c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb602de18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ffd30>, '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 0x102926db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f4be8>, '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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 11:57:14 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 11:57:14 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 11:57:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HL9mdDi3BN/Render', 11:57:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:14 INFO - 'HOME': '/Users/cltbld', 11:57:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:14 INFO - 'LOGNAME': 'cltbld', 11:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:14 INFO - 'MOZ_NO_REMOTE': '1', 11:57:14 INFO - 'NO_EM_RESTART': '1', 11:57:14 INFO - 'PAGER': '/bin/cat', 11:57:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:14 INFO - 'PWD': '/builds/slave/test', 11:57:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:14 INFO - 'SHELL': '/bin/bash', 11:57:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aIz5OlGAyM/Listeners', 11:57:14 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 11:57:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:14 INFO - 'USER': 'cltbld', 11:57:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:14 INFO - 'XPC_FLAGS': '0x0', 11:57:14 INFO - 'XPC_SERVICE_NAME': '0', 11:57:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:57:14 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 11:57:14 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 11:57:14 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 11:57:14 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 11:57:14 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 11:57:14 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 11:57:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:57:17 INFO - Installing collected packages: mozsystemmonitor 11:57:17 INFO - Running setup.py install for mozsystemmonitor 11:57:17 INFO - Successfully installed mozsystemmonitor 11:57:17 INFO - Cleaning up... 11:57:17 INFO - Return code: 0 11:57:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:57:17 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')]} 11:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:17 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')]} 11:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:17 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 0x102c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb602de18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ffd30>, '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 0x102926db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f4be8>, '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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 11:57:17 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 11:57:17 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 11:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HL9mdDi3BN/Render', 11:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:17 INFO - 'HOME': '/Users/cltbld', 11:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:17 INFO - 'LOGNAME': 'cltbld', 11:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:17 INFO - 'MOZ_NO_REMOTE': '1', 11:57:17 INFO - 'NO_EM_RESTART': '1', 11:57:17 INFO - 'PAGER': '/bin/cat', 11:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:17 INFO - 'PWD': '/builds/slave/test', 11:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:17 INFO - 'SHELL': '/bin/bash', 11:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aIz5OlGAyM/Listeners', 11:57:17 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 11:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:17 INFO - 'USER': 'cltbld', 11:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:17 INFO - 'XPC_FLAGS': '0x0', 11:57:17 INFO - 'XPC_SERVICE_NAME': '0', 11:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:17 INFO - Downloading/unpacking jsonschema==2.5.1 11:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:57:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:21 INFO - Downloading functools32-3.2.3-2.tar.gz 11:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:57:21 INFO - warning: no files found matching '*.txt' 11:57:21 INFO - no previously-included directories found matching 'build' 11:57:21 INFO - no previously-included directories found matching 'dist' 11:57:21 INFO - no previously-included directories found matching '.git*' 11:57:21 INFO - Installing collected packages: jsonschema, functools32 11:57:21 INFO - Running setup.py install for functools32 11:57:21 INFO - warning: no files found matching '*.txt' 11:57:21 INFO - no previously-included directories found matching 'build' 11:57:21 INFO - no previously-included directories found matching 'dist' 11:57:21 INFO - no previously-included directories found matching '.git*' 11:57:21 INFO - Successfully installed jsonschema functools32 11:57:21 INFO - Cleaning up... 11:57:21 INFO - Return code: 0 11:57:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:57:21 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')]} 11:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:21 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')]} 11:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:21 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 0x102c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb602de18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ffd30>, '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 0x102926db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f4be8>, '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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 11:57:21 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 11:57:21 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 11:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HL9mdDi3BN/Render', 11:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:21 INFO - 'HOME': '/Users/cltbld', 11:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:21 INFO - 'LOGNAME': 'cltbld', 11:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:21 INFO - 'MOZ_NO_REMOTE': '1', 11:57:21 INFO - 'NO_EM_RESTART': '1', 11:57:21 INFO - 'PAGER': '/bin/cat', 11:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:21 INFO - 'PWD': '/builds/slave/test', 11:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:21 INFO - 'SHELL': '/bin/bash', 11:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aIz5OlGAyM/Listeners', 11:57:21 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 11:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:21 INFO - 'USER': 'cltbld', 11:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:21 INFO - 'XPC_FLAGS': '0x0', 11:57:21 INFO - 'XPC_SERVICE_NAME': '0', 11:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:57:21 INFO - Cleaning up... 11:57:21 INFO - Return code: 0 11:57:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:57:21 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')]} 11:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:21 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')]} 11:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:21 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 0x102c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb602de18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ffd30>, '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 0x102926db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f4be8>, '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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 11:57:21 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 11:57:21 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 11:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HL9mdDi3BN/Render', 11:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:21 INFO - 'HOME': '/Users/cltbld', 11:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:21 INFO - 'LOGNAME': 'cltbld', 11:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:21 INFO - 'MOZ_NO_REMOTE': '1', 11:57:21 INFO - 'NO_EM_RESTART': '1', 11:57:21 INFO - 'PAGER': '/bin/cat', 11:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:21 INFO - 'PWD': '/builds/slave/test', 11:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:21 INFO - 'SHELL': '/bin/bash', 11:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aIz5OlGAyM/Listeners', 11:57:21 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 11:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:21 INFO - 'USER': 'cltbld', 11:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:21 INFO - 'XPC_FLAGS': '0x0', 11:57:21 INFO - 'XPC_SERVICE_NAME': '0', 11:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:22 INFO - Downloading/unpacking blobuploader==1.2.4 11:57:22 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 11:57:22 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 11:57:22 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 11:57:22 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 11:57:22 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 11:57:22 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 11:57:25 INFO - Downloading blobuploader-1.2.4.tar.gz 11:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:57:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:57: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 11:57: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 11:57: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 11:57: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 11:57: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 11:57: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 11:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:57:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:57:26 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 11:57:26 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 11:57:26 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 11:57:26 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 11:57:26 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 11:57:26 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 11:57:27 INFO - Downloading docopt-0.6.1.tar.gz 11:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:57:27 INFO - Installing collected packages: blobuploader, requests, docopt 11:57:27 INFO - Running setup.py install for blobuploader 11:57:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:57:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:57:27 INFO - Running setup.py install for requests 11:57:27 INFO - Running setup.py install for docopt 11:57:27 INFO - Successfully installed blobuploader requests docopt 11:57:27 INFO - Cleaning up... 11:57:27 INFO - Return code: 0 11:57:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:57:27 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')]} 11:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:27 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')]} 11:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:27 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 0x102c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb602de18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ffd30>, '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 0x102926db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f4be8>, '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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 11:57:27 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 11:57:27 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 11:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HL9mdDi3BN/Render', 11:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:27 INFO - 'HOME': '/Users/cltbld', 11:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:27 INFO - 'LOGNAME': 'cltbld', 11:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:27 INFO - 'MOZ_NO_REMOTE': '1', 11:57:27 INFO - 'NO_EM_RESTART': '1', 11:57:27 INFO - 'PAGER': '/bin/cat', 11:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:27 INFO - 'PWD': '/builds/slave/test', 11:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:27 INFO - 'SHELL': '/bin/bash', 11:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aIz5OlGAyM/Listeners', 11:57:27 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 11:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:27 INFO - 'USER': 'cltbld', 11:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:27 INFO - 'XPC_FLAGS': '0x0', 11:57:27 INFO - 'XPC_SERVICE_NAME': '0', 11:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:57:28 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-AHJQxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:57:28 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-OvG3Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:57:28 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-LUzC8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:57:28 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-tmqEqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:57:28 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-gQLia_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:57:28 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-L_K7uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:57:28 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-VgtT24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:57:29 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Scym7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:57:29 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-HBspoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:57:29 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Qzq4o6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:57:29 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-g4wirK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:57:29 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-IOOdyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:57:29 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-3cmiU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:57:29 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-TBMxBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:29 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-uNr3ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:57:29 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-s3wRuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:57:29 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-SP4N1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:57:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:57:30 INFO - Running setup.py install for manifestparser 11:57:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:57:30 INFO - Running setup.py install for mozcrash 11:57:30 INFO - Running setup.py install for mozdebug 11:57:30 INFO - Running setup.py install for mozdevice 11:57:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:57:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:57:30 INFO - Running setup.py install for mozfile 11:57:30 INFO - Running setup.py install for mozhttpd 11:57:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Running setup.py install for mozinfo 11:57:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Running setup.py install for mozInstall 11:57:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Running setup.py install for mozleak 11:57:31 INFO - Running setup.py install for mozlog 11:57:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Running setup.py install for moznetwork 11:57:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:57:31 INFO - Running setup.py install for mozprocess 11:57:31 INFO - Running setup.py install for mozprofile 11:57:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:57:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:57:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:57:32 INFO - Running setup.py install for mozrunner 11:57:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:57:32 INFO - Running setup.py install for mozscreenshot 11:57:32 INFO - Running setup.py install for moztest 11:57:32 INFO - Running setup.py install for mozversion 11:57:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:57:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:57:32 INFO - Cleaning up... 11:57:32 INFO - Return code: 0 11:57:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:57:32 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')]} 11:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57: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')]} 11:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:33 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 0x102c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb602de18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ffd30>, '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 0x102926db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f4be8>, '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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 11:57:33 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 11:57:33 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 11:57:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HL9mdDi3BN/Render', 11:57:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:33 INFO - 'HOME': '/Users/cltbld', 11:57:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:33 INFO - 'LOGNAME': 'cltbld', 11:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:33 INFO - 'MOZ_NO_REMOTE': '1', 11:57:33 INFO - 'NO_EM_RESTART': '1', 11:57:33 INFO - 'PAGER': '/bin/cat', 11:57:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:33 INFO - 'PWD': '/builds/slave/test', 11:57:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:33 INFO - 'SHELL': '/bin/bash', 11:57:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aIz5OlGAyM/Listeners', 11:57:33 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 11:57:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:33 INFO - 'USER': 'cltbld', 11:57:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:33 INFO - 'XPC_FLAGS': '0x0', 11:57:33 INFO - 'XPC_SERVICE_NAME': '0', 11:57:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:57:33 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-PpASd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:57:33 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)) 11:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:57:33 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Jc_izY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:57:34 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-02E97i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:57:34 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-qcUEn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:57:34 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-qX8hfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:57:34 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-jkQC0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:57:34 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-aFGXLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:57:34 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-JhHMuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:57:34 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-9L3QLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:57:34 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-2sNQRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:57:34 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-H3fHeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:57:34 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)) 11:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:57:34 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-N4NeEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 11:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:57:35 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-DIgB5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:57:35 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)) 11:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:57:35 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-kCAELU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:57:35 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)) 11:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:35 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-31OLG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:35 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)) 11:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:57:35 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-nDnWJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:57:35 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)) 11:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:57:35 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-0Q9TFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:57:35 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)) 11:57:35 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)) 11:57:35 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)) 11:57:35 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)) 11:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:57:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:57:35 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 11:57:35 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 11:57:35 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 11:57:35 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 11:57:35 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 11:57:35 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 11:57:38 INFO - Downloading blessings-1.6.tar.gz 11:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:57:38 INFO - Installing collected packages: blessings 11:57:38 INFO - Running setup.py install for blessings 11:57:38 INFO - Successfully installed blessings 11:57:38 INFO - Cleaning up... 11:57:38 INFO - Return code: 0 11:57:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:57:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:57:39 INFO - Reading from file tmpfile_stdout 11:57:39 INFO - Current package versions: 11:57:39 INFO - blessings == 1.6 11:57:39 INFO - blobuploader == 1.2.4 11:57:39 INFO - docopt == 0.6.1 11:57:39 INFO - functools32 == 3.2.3-2 11:57:39 INFO - jsonschema == 2.5.1 11:57:39 INFO - manifestparser == 1.1 11:57:39 INFO - mozInstall == 1.12 11:57:39 INFO - mozcrash == 1.0 11:57:39 INFO - mozdebug == 0.1 11:57:39 INFO - mozdevice == 0.49 11:57:39 INFO - mozfile == 1.2 11:57:39 INFO - mozhttpd == 0.7 11:57:39 INFO - mozinfo == 0.9 11:57:39 INFO - mozleak == 0.1 11:57:39 INFO - mozlog == 3.4 11:57:39 INFO - moznetwork == 0.27 11:57:39 INFO - mozprocess == 0.24 11:57:39 INFO - mozprofile == 0.28 11:57:39 INFO - mozrunner == 6.13 11:57:39 INFO - mozscreenshot == 0.1 11:57:39 INFO - mozsystemmonitor == 0.3 11:57:39 INFO - moztest == 0.8 11:57:39 INFO - mozversion == 1.4 11:57:39 INFO - psutil == 3.1.1 11:57:39 INFO - requests == 1.2.3 11:57:39 INFO - wsgiref == 0.1.2 11:57:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:39 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 0x102c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb602de18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ffd30>, '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 0x102926db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f4be8>, '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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 11:57:39 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 11:57:39 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 11:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HL9mdDi3BN/Render', 11:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:39 INFO - 'HOME': '/Users/cltbld', 11:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:39 INFO - 'LOGNAME': 'cltbld', 11:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:39 INFO - 'MOZ_NO_REMOTE': '1', 11:57:39 INFO - 'NO_EM_RESTART': '1', 11:57:39 INFO - 'PAGER': '/bin/cat', 11:57:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:39 INFO - 'PWD': '/builds/slave/test', 11:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:39 INFO - 'SHELL': '/bin/bash', 11:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aIz5OlGAyM/Listeners', 11:57:39 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 11:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:39 INFO - 'USER': 'cltbld', 11:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:39 INFO - 'XPC_FLAGS': '0x0', 11:57:39 INFO - 'XPC_SERVICE_NAME': '0', 11:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 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)) 11:57:39 INFO - Cleaning up... 11:57:39 INFO - Return code: 0 11:57:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb602de18e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ffd30>, '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 0x102926db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f4be8>, '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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 11:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HL9mdDi3BN/Render', 11:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:39 INFO - 'HOME': '/Users/cltbld', 11:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:39 INFO - 'LOGNAME': 'cltbld', 11:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:39 INFO - 'MOZ_NO_REMOTE': '1', 11:57:39 INFO - 'NO_EM_RESTART': '1', 11:57:39 INFO - 'PAGER': '/bin/cat', 11:57:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:39 INFO - 'PWD': '/builds/slave/test', 11:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:39 INFO - 'SHELL': '/bin/bash', 11:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aIz5OlGAyM/Listeners', 11:57:39 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 11:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:39 INFO - 'USER': 'cltbld', 11:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:39 INFO - 'XPC_FLAGS': '0x0', 11:57:39 INFO - 'XPC_SERVICE_NAME': '0', 11:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:57:39 INFO - Cleaning up... 11:57:39 INFO - Return code: 0 11:57:39 INFO - Running post-action listener: _resource_record_post_action 11:57:39 INFO - Running post-action listener: _start_resource_monitoring 11:57:39 INFO - Starting resource monitoring. 11:57:39 INFO - [mozharness: 2017-04-04 18:57:39.761780Z] Finished create-virtualenv step (success) 11:57:39 INFO - [mozharness: 2017-04-04 18:57:39.762692Z] Running install step. 11:57:39 INFO - Running pre-action listener: _resource_record_pre_action 11:57:39 INFO - Running main action method: install 11:57:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:57:40 INFO - Reading from file tmpfile_stdout 11:57:40 INFO - Detecting whether we're running mozinstall >=1.0... 11:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:57:40 INFO - Reading from file tmpfile_stdout 11:57:40 INFO - Output received: 11:57:40 INFO - Usage: mozinstall [options] installer 11:57:40 INFO - Options: 11:57:40 INFO - -h, --help show this help message and exit 11:57:40 INFO - -d DEST, --destination=DEST 11:57:40 INFO - Directory to install application into. [default: 11:57:40 INFO - "/builds/slave/test"] 11:57:40 INFO - --app=APP Application being installed. [default: firefox] 11:57:40 INFO - mkdir: /builds/slave/test/build/application 11:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:57:54 INFO - Reading from file tmpfile_stdout 11:57:54 INFO - Output received: 11:57:54 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:57:54 INFO - Running post-action listener: _resource_record_post_action 11:57:54 INFO - [mozharness: 2017-04-04 18:57:54.876962Z] Finished install step (success) 11:57:54 INFO - [mozharness: 2017-04-04 18:57:54.877096Z] Running run-tests step. 11:57:54 INFO - Running pre-action listener: _resource_record_pre_action 11:57:54 INFO - Running main action method: run_tests 11:57:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:57:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:57:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:57:54 INFO - 2017-04-04 11:57:54.890 screenresolution[1640:7436] starting screenresolution argv=screenresolution get 11:57:54 INFO - 2017-04-04 11:57:54.892 screenresolution[1640:7436] Display 0: 1600x1200x32@60 11:57:54 INFO - 2017-04-04 11:57:54.898 screenresolution[1641:7439] starting screenresolution argv=screenresolution list 11:57:54 INFO - Available Modes on Display 0 11:57:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:57:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:57:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:57:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:57:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:57:55 INFO - Intel Iris: 11:57:55 INFO - Chipset Model: Intel Iris 11:57:55 INFO - Type: GPU 11:57:55 INFO - Bus: Built-In 11:57:55 INFO - VRAM (Dynamic, Max): 1536 MB 11:57:55 INFO - Vendor: Intel (0x8086) 11:57:55 INFO - Device ID: 0x0a2e 11:57:55 INFO - Revision ID: 0x0009 11:57:55 INFO - Displays: 11:57:55 INFO - Display: 11:57:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:57:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:57:55 INFO - Display Serial Number: 1600x1200 60 11:57:55 INFO - Main Display: Yes 11:57:55 INFO - Mirror: Off 11:57:55 INFO - Online: Yes 11:57:55 INFO - Rotation: Supported 11:57:55 INFO - Return code: 0 11:57:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:57:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:57:55 INFO - Python 2.7.3 11:57:55 INFO - Return code: 0 11:57:55 INFO - grabbing minidump binary from tooltool 11:57:55 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')]} 11:57:55 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 0x1029ffd30>, '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 0x102926db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:57:55 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 11:57:55 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 11:57:55 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 11:57:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:57:55 INFO - Return code: 0 11:57:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:57:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:57:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:57:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:57:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:57:55 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/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 11:57:55 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/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0357 --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 11:57:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HL9mdDi3BN/Render', 11:57:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:57:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:57:55 INFO - 'HOME': '/Users/cltbld', 11:57:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:57:55 INFO - 'LOGNAME': 'cltbld', 11:57:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:57:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:55 INFO - 'MOZ_NO_REMOTE': '1', 11:57:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:57:55 INFO - 'NO_EM_RESTART': '1', 11:57:55 INFO - 'PAGER': '/bin/cat', 11:57:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:55 INFO - 'PWD': '/builds/slave/test', 11:57:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:57:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:57:55 INFO - 'SHELL': '/bin/bash', 11:57:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aIz5OlGAyM/Listeners', 11:57:55 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 11:57:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:57:55 INFO - 'USER': 'cltbld', 11:57:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:57:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:55 INFO - 'XPC_FLAGS': '0x0', 11:57:55 INFO - 'XPC_SERVICE_NAME': '0', 11:57:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:57:55 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/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 11:57:55 INFO - mozversion application_buildid: 20170404110128 11:57:55 INFO - mozversion application_changeset: 6e2ce3dd9d87e587a66426931f5146b7e73db3d0 11:57:55 INFO - mozversion application_display_name: Firefox 11:57:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:57:55 INFO - mozversion application_name: Firefox 11:57:55 INFO - mozversion application_remotingname: firefox 11:57:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:57:55 INFO - mozversion application_vendor: Mozilla 11:57:55 INFO - mozversion application_version: 53.0 11:57:55 INFO - mozversion platform_buildid: 20170404110128 11:57:55 INFO - mozversion platform_changeset: 6e2ce3dd9d87e587a66426931f5146b7e73db3d0 11:57:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:57:55 INFO - mozversion platform_version: 53.0 11:57:55 INFO - using testdate: 1491332275 11:57:55 INFO - actual date: 1491332275 11:57:55 INFO - starting webserver on 'localhost:49241' 11:57:55 INFO - SUITE-START | Running 2 tests 11:57:55 INFO - TEST-START | dromaeo_css 11:57:55 INFO - operating with platform_type : mac_ 11:57:55 INFO - Initialising browser for dromaeo_css test... 11:57:55 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpTEHxmp/profile http://localhost:49241/getInfo.html) 11:57:57 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 11:57:57 INFO - PROCESS | 1651 | colorDepth:24 11:57:57 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 11:57:57 INFO - PROCESS | 1651 | __metrics 11:57:57 INFO - PROCESS | 1651 | 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" 11:57:57 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:57:58 INFO - TEST-INFO | 1651: exit 0 11:57:58 INFO - Browser initialized. 11:57:58 INFO - Running cycle 1/1 for dromaeo_css test... 11:57:58 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpTEHxmp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:10 INFO - PROCESS | 1654 | RSS: Main: 163790848 11:58:10 INFO - PROCESS | 1654 | 12:01:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 12:01:14 INFO - PROCESS | 1654 | RSS: Main: 319004672 12:01:14 INFO - PROCESS | 1654 | 12:04:17 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 12:04:18 INFO - PROCESS | 1654 | RSS: Main: 307040256 12:04:18 INFO - PROCESS | 1654 | 12:07:20 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 12:07:21 INFO - PROCESS | 1654 | RSS: Main: 279072768 12:07:21 INFO - PROCESS | 1654 | 12:10:23 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 12:10:24 INFO - PROCESS | 1654 | RSS: Main: 286113792 12:10:24 INFO - PROCESS | 1654 | 12:13:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 12:13:28 INFO - PROCESS | 1654 | RSS: Main: 270589952 12:13:28 INFO - PROCESS | 1654 | 12:16:31 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 12:16:31 INFO - PROCESS | 1654 | RSS: Main: 309084160 12:16:31 INFO - PROCESS | 1654 | 12:16:31 INFO - PROCESS | 1654 | __start_tp_report 12:16:31 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 12:16:31 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 12:16:31 INFO - PROCESS | 1654 | |i|pagename|runs| 12:16:31 INFO - PROCESS | 1654 | |0;dojo.html;3446.4485682290824;3446.7414943879207;3488.5464889564387;3491.8254087295627;3510.3330367230224;5902.763889444423;5923.970380148098;5939.64362138272;5956.4936980356615;5972.761089556423;5879.647221166733;5903;5984.670843103628;5990.520758339333;5996.8200953971345;4023.7585744855255;4972.676776009566;5303.549198318147;5385.084535628933;5411.621186516945;5285.550728188108;5295.602829787781;5302.655327403706;5409.2967914171295;5433.4566543345545;5322.467753224666;5342.439043900393;5349.679019258838;5399.83800485986;5433.022056029913;5391.946080539184;5396.244525766376;5403.918941215885;5412.99859525987;5414.187871819219;5217.58259339252;5277.577793776489;5344.011357898801;5363.973180134113;5422.53908417785;5780.017397042513;5800.245968024172;5872.970635146839;5875.471207591295;5895.675737834417;6239.781607643756;6266.624002559861;6267.780627678009;6274.592151510183;6281.623102613812;6218.22272215973;6252.968735156341;6264.436200741955;6275.592086514408;6276.215473065867;5798.304203495565;5907.2911250650195;5916.674582897982;5966;5979.970100149559;6274.341194174546;6323.7786677466065;6331.715072821734;6343.9682801585695;6347.333529979378;6261.342559031327;6296.307406185316;6298;6304.842378940563;6305.211848518935;6201.534884883652;6259.436650701367;6267.4986001120715;6269.498440124779;6275.341089185661;6180.381961803783;6184.226971628546;6225.221847269091;6241.438270555672;6247.656378899113;6247.156633854463;6258.3428739982555;6258.812235632939;6268.968655156787;6278.529110316745;5054.1407960646775;5063.822766203165;5107.846764597068;5113.258577506315;5114.616403769732;4531.56950089741;4542.886427839265;4550.13547425988;4628.305754136839;4629.213033784265;4930.211166213388;5885.3820348862755;5906.7637294508595;5964.1650168976375;6025.367336429612;6167.198264225622;6201.875962480725;6260.123582698426;6261.812145635638;6267.71795269214;5715.342735585377;5981.461668449861;5994.130851026577;6000.819975400745;6006.729697163638;5500.697461639648;5517.44825517445;5539.9169012464845;5540.168974653753;5558.527525160407;6338.619682819046;6414.743410263537;6417.197850268716;6432.2602900667025;6451.903221451682;6254.249490061222;6261.96869015652;6276.1213430118905;6282.2147231596055;6285.779997700059;6233.252009758858;6288.11966324724;6289.245290565162;6329.5252856036905;6339.746410143543;5509.47659972302;6248;6254.21822272216;6255.874882502416;6266.655333956676;6224.037386163909;6248.718807653758;6257.1552840367785;6267;6268;6110.5587591967305;6193;6211.844703882259;6269.68651567429;6280.528960328085;6169.6915154241215;6195.938040619536;6205;6271.184745982993;6287.371262873676;5993.921094202911;6176.845578860564;6194.287656919331;6194.5973511721595;6199.938000619936;5108.386993560796;5919.792807251725;6214.782482613087;6225.657588832477;6234.781782637768;6013.579049466671;6051.667158306335;6094.573379863367;6112.407400958353;6177.444030037318 12:16:31 INFO - PROCESS | 1654 | |1;ext.html;470.4730701614193;480.1573238965616;509.19038728421805;521.5358331085334;570.949453006468;32285.031449056536;42322;43732.906677333085;44025.999999999956;46206.30690539636;45001.77499112508;45245;45287.77356113223;45395.773021134846;45421;9525.19035881951;9759.121679048883;9766;9772.511374431286;9774.218062555014;8955.19403253707;9220.124088211644;11581.36302503362;11841.822372664417;11913.583024594142;11845.526178952874;11905.345206013666;11926.7614647707;11928.52285908567;11961;11707.765844683145;11776.646700598996;11788.29270243788;11807.173497855196;11819.763604727943;11715.941420292844;11786.646400607995;11798.410079496076;11801.586944456903;11804.822927656092;42202.155956881;42270;42393.728188154404;42527.57472425298;42589.57410425887;4049.5343035550995;4053.1285773558825;4100.835966561334;4123.958760412387;4136.607022332873;30528.236794080105;30959;32369.83815080933;32775.6722432775;33088.83455582731;3227.7256433203206;3299.884504042371;3347.782394144373;3515.5781306243157;3552.7513074084823;514228;515135;515542.9999999963;516804;517279;69516.65241673759;70164.2983570168;70219;70556;70566.9414958776;72010.63994679993;72179.63910180521;72202.63898680577;72229.6388518054;72255;17199.91400043017;17890.91054544745;17894.55263618394;17917.014564199093;17963.191656375493;12538.937305313415;13740.65648358799;13843.653908652162;13880.930595347161;13887.79168312476;17102.48692539226;17139.400120995706;18192.363267285582;22153.556928861333;22319.330420087423;8187.7718342247945;8299.709510167237;8873.556322183866;8916.509591972374;9001.504917229484;893.629143905272;895.785011597225;898.7303808857316;908.5502676175204;946.0444950599943;31715.52426713601;31942.68057319397;32186;32824.179395515304;32829.88315024514;975.770693886936;1049.800537897797;1061.6496556136456;1067;1088.6135421925103;14276.85723142776;14728.55814325572;14747.41010359595;14803.777943330859;15135;601592;694019.2392304251;696551;698025;700185;48485;54097;56519.71740141355;57261.71369143211;57510;1346.8720471555187;1388.6806034612096;1397.6366144802425;1463.721892840357;1502.3089378885834;26721;27544.76048577859;30322.241943951576;30541.694583053886;30768.923087692718;48930.266046008626;49356;49387.75306123446;49604.25593616171;49665.00669986652;574370;578742;579890;580150;580544;24327.878360608083;24673.87663061673;24709.135180268604;24900.875495622407;26492.735072649026;37918;38237.85286441411;42702.78648606737;43592.56407436012;43731;28215.43569128565;30986.225344366572;31423;32508.099028116776;32567;30359.544606831358;30851.537226942062;30879.845600771852;31722.682773172895;31904.521432179;35674.64325356817;36544.81727591345;36865.815670921475;36896.63103368932;37064.62935370612;30272.243193920327;30923.536146958264;31388;31570.842145789124;32054.519182211818;24525.50948980975;24550.50898982046;24663.166929479372;24827.379315517257;25012.62481062749 12:16:31 INFO - PROCESS | 1654 | |2;jquery.html;399.6922369775271;405.7362714235747;408.4322791320064;413.36961134270234;429.44172575651663;19158.616827663438;20703;20918.267860624863;21420.785792142073;21938.89030554847;22357.55284894301;22445.102195912186;23002.42493937648;23318.300450986455;23445.41386465335;5944.197533333009;6220.875582488347;6260.7808726694575;6265.7493700251935;6284.937150628503;5402.243685883979;5731.083026715726;6077.544184186182;6108.664023478706;6115.663638499881;6061.393860613947;6065.302490213638;6073.089036644516;6074.605150665193;6081.270247570298;5847.5614328925285;6045.969770151165;6106.48094911933;6116.357782432825;6120.326764055995;5388.91916621251;5389.541888939445;5395.136778115482;5400.83797486076;5498.422665620093;10580.78838423235;13917.58247252584;14099.22454265015;14114.85885141156;14122.788158177636;2688.314479807656;2695.663042119735;2700.4599080184043;2700.7839372850126;2710.417260289047;10262.281640285182;10529.631462898838;10749.62376316825;10778.191635627281;11049;1833.4499650104915;1840.5122642499748;1864.8787828791221;1889.9338523151762;1890.3383815664545;130849;138252.30873845666;140635.29682351524;141883;143914;12028.218165819193;12060.336681482428;12259.93870030662;12267.69330766738;12458.937705311597;16241.187940603158;16280.511584652479;16298.918505407633;16313.91843040801;16317.836821631869;8317.126701696356;8602.698905538402;8664.78338041554;8747;8776.648934042567;8255.339572834158;8271.090180080186;8272.420930534925;8392.454490458224;8447.577621118919;4922.680025798311;4938.283948827472;4942.851714448572;4955.702657840469;5097.8725531862;2006.2476571285767;2045.202371075282;2055.496403381151;2055.9588808223752;2064.4013236161345;981.9361741486781;1013.6705570689555;1015.7155996321042;1021.1269364693229;1053.8103141434462;21288.78711212899;22167.00248488822;22221.555568888532;22341.329760107223;22372.776272237395;1004.7186787699455;1009.9697009089739;1041.8697662792151;1042.1766804224578;1048.9108425783893;10255.897441025494;10725.088367488695;10848.94575527133;11302.039326657161;11307.321560706385;742971;753398;768065;780027;785933;150913;152403.47596524114;154364;157413;158513;1001.8998100189923;1014.1278500489573;1028.88682244953;1032.0402026115635;1033.6950599572995;18883.433496995112;19034;19494.902525487283;19519.414417567496;19570.706439403704;55858.720706396205;56477.43522564722;57010;57058.7147064262;58283.708581458515;81790;84179.73730393927;84404.57797710971;85045.7243141341;85145.2687384477;8257.752267431986;8305.418620696493;8528.914710852812;8885.689000884939;8988.86516702237;8298.045724741733;13012.28432436225;13453.529126480526;13666.590002299548;13885.305734713425;11552.573645036155;11779.705507362385;11793.351365674971;11850.940745296219;11947.745486724116;9387.29595280343;9426.182396129578;10519.10587600032;10620.150387969099;11115.166362523005;11663.533458661559;11875.881241187477;11934.641960741192;12059.51761929548;12144.75710485803;8511.191436813493;8621.568921553771;8696.869546956674;8985.191332780081;8988;10331.431771252654;11083.526067865789;11292.43537823122;11392.715182120513;11696 12:16:31 INFO - PROCESS | 1654 | |3;mootools.html;1264.0203842022438;1389.562287879318;1486.6952274783664;1514.787929689843;1529.3500262388482;7603.35371493423;8063.9596802015985;8329.541875196854;8556.058833528323;8578.571071446433;8362.58187090646;8466;8491.617877195526;8500.192481714243;8542.10307917669;2381.261808839257;2415.1667674652217;2421.624648179535;2426.9878650606724;2428.890699918508;2001.2195243854908;2144.6246906791325;2218.9112435502643;2439.743826898177;2448.424620214248;2406.867622280774;2407.6508906208587;2412.3004328744732;2413.372523143986;2420.7579242075826;2357.8938947747306;2372.454335502827;2396.772306630876;2419.2137555294426;2422.4186195313173;2030.3198428526462;2400.567897778399;2407.5666380051584;2430.7569243075727;2436.7075950886006;8508.276796472308;8589.269912057483;8600.268977136951;8605.31157507398;8608.39741218115;5215.869603259911;5360.517553420172;5364.141737322048;5367.382750983609;5367.624266301361;3397.59228892532;3508.8946981700938;3561.679448849616;3566.3402270580027;3570.1610121621397;1204.3797444316185;1249.93750312484;1255.6484184428375;1302.9087963842535;1308.6597484654058;10863.51114199863;10944.343339399662;10954.34273943558;10963.232573719843;10994.175436842188;4498.347739577808;4697.436307643105;4736.407949006374;4840.564349208517;4846.491118432585;9610.855837162448;9623.230141588656;9631.422114673142;9635.56639951204;9643.469609171563;5413.944280865272;5415.918761218585;5431.755570999315;5432.59255555827;5446.482584154578;4490.842820501267;4855.368802055781;4905.779239934212;4949.232868905326;4960.057589058068;3718.200586873835;3815.42768584709;3935.9212815743526;4013.257547353749;4021.155557332993;1161.4018780328138;1281.7180220351509;1295.7149427126017;1304.8042793580848;1305.4582348325528;904.9592768325309;915.7225670190047;930;944.419182202954;989.302541708094;5593.468620481048;5605.355384130877;5750.2237197978575;5869.589128760946;5933.169356290123;979.2900147393083;1011.1556850030161;1017.9260879771912;1029.3978022856713;1049.8320268756963;3337.89849349714;3679.68722658577;3726.7391282609956;3868.9806550967064;3902.8096430588375;9904.009599040182;10132.34139780912;10238.9761023897;10257.230707696803;10264;9910.900890991143;9936.205103591696;10189.949050254701;10205.38767673942;10222.182225421948;8066.637001334954;8134.471259368122;8139.918600814034;8152.8777068344025;8156.714514991947;5539.667619942817;5544.473275038865;5601.271834661468;5729.512991395778;5769.711514424178;9244.768880777765;9458.527073646152;9458.574364153492;9464.621415143318;9469.053094690476;9274.860877086714;9473.384230025027;9474.099960503741;9676.080772326617;9689;7180.497365184387;7276.745313914199;7305.525140865827;7362.3373896349585;7386.963065184855;7319.63401829917;7542.622868856645;7703.845923081395;7937.801554961172;7967.2431119043595;6952;6994.825129371807;7081.433485321265;7124.323189297009;7132.037174981311;6946.270641582561;6963.268856770169;7002.1947476040905;7131.679074441558;7165.390941770008;6435.581687190505;6491.961286194186;6577.572457790228;6587.308332625005;6592.340765923369;4950.331705219894;4951.331570237971;5066.72133032672;5128.153854613947;5239.921401178909;5014.197728363444;5089.338386009943;5123.129068058364;5151.768170432265;5315.813946511854 12:16:31 INFO - PROCESS | 1654 | |4;prototype.html;368.09999551097565;372.5734034530463;377.901745546158;386.7891998860621;387.33765261403;5186.247994040867;5445.346558412991;5461.290032295796;5476.78092876285;5493.313335833021;4235.491740991078;4660.9512859606575;5281.174571604192;5304.681719096857;5408.810691625794;3694.094946738053;4184.414182014513;4199.2441360555085;4205.897051474263;4298.634616057639;3608.1160115771672;4257.595528424795;4260.786960651971;4270.1459708058355;4313.698041137121;3523;4016.1566071124953;4270.0784646909015;4281.764502952336;4286.849960251392;4125.711200216001;4220.349397770921;4247.681423893189;4263.211305908386;4264.914701705949;3748.9812550937345;3766.7551609145594;3791.388659819566;3809.1619843634357;3845.192509572993;4818.614510839125;5249.553787928031;5396.541293990015;5409.891802163974;5455.918161227585;4201.122231271589;4904.258988059223;4919.508049195088;4997.475265097185;4997.950020499785;4918.926216106761;5023.66872778714;5769.538436925036;5795.565332600072;5824.951508728427;2789.330560665446;4217.924429270547;4227.471566054243;4232.343986682069;4241.600271910263;5065.240213967897;6066.664334231353;6072;6085.908711369333;6087.969560152215;3636.4545318201954;4034.4755181826176;4040.4141399496907;4050.311447054008;4060.9695152423787;4044.1102957349335;4073.91852162961;4102.528209255974;4126.236646220459;4166.812493437742;4016.1124271592303;4435.667324950641;4667.159911216014;4753.47711751714;4760.928586071212;5289.894202116013;5371.811986580451;5827.329857066492;5841.29078035442;5852.180694702745;1311.3770958794496;1323.4970711129708;1329.5413082486527;1335.2122247873606;1353.5465619017739;751.3538357012965;767.4574106046774;787.9724209652635;846.4667259626395;849.7084431663836;5182.481751824787;5203.245529398292;5229.92155117666;5244.505315984926;5270;5343.519083282523;5404.000259951921;5476.561875049986;5498.972505137529;5763.740631671585;4274;4438.201123797748;4650.302824361862;4850.563449289581;5225.399079105876;2389.510150419195;2675.906343277976;2859.7140285971236;2950.4099180164053;2958.541426078961;5040.924386134211;5447.610859230871;5649.971750141223;5653.519450846642;5876.268569458424;4900.901981960341;5415.014631125803;5707.632496826892;5980.820575382745;6044.274687037584;5435.342220622669;5623.550115990711;6031.642880351974;6144.293406258248;6219;5261.289725886956;5704.229928959538;5766.971165144315;5917.230760001345;5968.46283834457;5547.44525547442;5587.664740115606;5776.855578610568;5841.678707671119;5857.242827151923;5478.780848766164;5781.4968108291305;5969.852641619965;6079.592295585665;6106.053561697944;3947.782871942071;3993.5008123984503;4005.619466150711;4030.6573941215324;4039.4142849287277;5617.241672374177;5873.353931067493;5970.373110823475;5998.550108741949;6005.948958932082;5188.766505507186;5199.506046925536;5306.071437498345;5681.77272909079;5797.275340582427;4950.45544990058;5727;5751.4536119068625;5774.105013722879;5841.824745257649;4815.518448155157;5635.380108188014;5736.483716465538;5749.396313387034;5755.668954073607;5052.065367906949;5709.3719690834805;5718.456746609066;5743.770249189985;5838;4801.95198048029;5660.915086273627;5674.2623458950075;5712.314522257356;5715.942550628147 12:16:31 INFO - PROCESS | 1654 | |5;yui.html;743.9510636717102;763.435058057038;792.9405294602906;854.6410507586813;870.3124531620018;15429.151396673178;16065.518034458984;16080;16091.678166436664;16137.919310403446;14600.196989165592;14634.780478292807;14719.04326218795;14733.631659208499;14740.189289589069;704.3484776581668;877.9648814047447;889.5685592487638;891.4428482198626;891.7012800711769;680.6936878404713;693.6323748413349;697.5082566790426;723.4104205072849;725.8802297620887;946.8248374050788;948.0614191949954;948.6395169835453;952.9142377186051;954.5990683912738;943.5753910740194;945.0596656326929;945.3902233059672;946.9384490008127;947.0718695678205;703.1597241296653;703.1632357494565;703.714995426853;704.8660754456688;706.6007705646344;13742.519011834538;15092.245387730569;15952.361905523765;16008.599785005468;16318.776091793163;14720.190389528572;14892.925535372255;15162.393504259817;15196.164210968393;15350;11785.175037747362;11800.90768540219;11897.762044759056;11945.343006134659;12069.215500992408;3783.564890037653;3791.0332865119494;3816.9809150954065;3919.902002449933;4052.7770972596495;85085.72371414433;96800.51599742027;104154.9169016623;104549;108264.45867770689;9835.901640983499;10958.18496084945;11491.3679747613;11665.358405287621;11737.178397512263;24152.275431737075;24671.62992555113;24892.875535622206;24898.626520602207;24964.375890602518;6651.368120028589;8189.7133600323705;8199.672013119527;8287.875681864776;8358.205970432798;4249.617534421917;4403.867883963422;4494.4157259556705;4503.752293623882;4531.954680453153;3501.2647344057523;3584.8386822593047;3588.9820550897603;3595.065283026432;3597.1546686528645;662.1170896583886;675.864827034595;696.154172680196;698.9266127056687;699.1610067918416;643.2859525926218;658.5127006015514;675.9662016899135;677.6306912732573;687.7214728035153;9501.287403444769;10077.798444031077;10305.021023002802;10437.68686939393;10494.73763155912;563.0580218359041;631.5673763472037;660.5277226782873;670.4267850987433;672.5090683800853;4934.235193545006;4942.9258561121615;4964.528369804862;4973.925391119136;4979.576735977483;104776.95223047672;105600.47199763951;108775.45612271888;108835.91164088417;112939;76530.61734691402;79618.80571791428;87157;89675.65486517578;92446.0755392451;53474.00645055535;79326.60336698279;82199.5890020546;83864;84511.5774421124;7773.3004029637605;9254.93568239661;10468.947655261674;10932.617358392417;11305.26515776472;51452.22821657753;51896.42885422554;51906.221406678174;52365;52804.73597631987;72003.63998179976;72495;73445.63277183793;73878.89181662387;74183;13206.075574709677;13382.732794128022;13538.323083845966;13992.650183745081;14041.227732474403;14954;14960.821627852478;15365.308561114553;15411.691766164839;15990;13651.11267767592;14047.508337208148;14303;14381;14985.850141498882;13509.716576925177;13803.930980345034;14349.713005740035;14381.352839122055;14456.710865782416;13632.318384080558;13969.650758731113;14092.859071409155;14153.08004979673;14211.005229633827;9784.364016338915;9936.602535898483;10092.495375231356;10349.586016559253;10405.271630985759;9087.182153605943;10855.185861060294;11405.258658187191;11427.257228280136;11481.770364592829 12:16:31 INFO - PROCESS | 1654 | __end_tp_report 12:16:31 INFO - PROCESS | 1654 | __start_cc_report 12:16:31 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1607 12:16:31 INFO - PROCESS | 1654 | __end_cc_report 12:16:31 INFO - PROCESS | 1654 | __startTimestamp1491333391532__endTimestamp 12:16:31 INFO - PROCESS | 1654 | 12:16:31 INFO - PROCESS | 1654 | ------- Summary: start ------- 12:16:31 INFO - PROCESS | 1654 | Number of tests: 6 12:16:31 INFO - PROCESS | 1654 | 12:16:31 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5834.39 Median:6110.56 stddev:632.35 (10.3%) stddev-sans-first:605.91 12:16:31 INFO - PROCESS | 1654 | Values: 3446.4 3446.7 3488.5 3491.8 3510.3 5902.8 5924.0 5939.6 5956.5 5972.8 5879.6 5903.0 5984.7 5990.5 5996.8 4023.8 4972.7 5303.5 5385.1 5411.6 5285.6 5295.6 5302.7 5409.3 5433.5 5322.5 5342.4 5349.7 5399.8 5433.0 5391.9 5396.2 5403.9 5413.0 5414.2 5217.6 5277.6 5344.0 5364.0 5422.5 5780.0 5800.2 5873.0 5875.5 5895.7 6239.8 6266.6 6267.8 6274.6 6281.6 6218.2 6253.0 6264.4 6275.6 6276.2 5798.3 5907.3 5916.7 5966.0 5980.0 6274.3 6323.8 6331.7 6344.0 6347.3 6261.3 6296.3 6298.0 6304.8 6305.2 6201.5 6259.4 6267.5 6269.5 6275.3 6180.4 6184.2 6225.2 6241.4 6247.7 6247.2 6258.3 6258.8 6269.0 6278.5 5054.1 5063.8 5107.8 5113.3 5114.6 4531.6 4542.9 4550.1 4628.3 4629.2 4930.2 5885.4 5906.8 5964.2 6025.4 6167.2 6201.9 6260.1 6261.8 6267.7 5715.3 5981.5 5994.1 6000.8 6006.7 5500.7 5517.4 5539.9 5540.2 5558.5 6338.6 6414.7 6417.2 6432.3 6451.9 6254.2 6262.0 6276.1 6282.2 6285.8 6233.3 6288.1 6289.2 6329.5 6339.7 5509.5 6248.0 6254.2 6255.9 6266.7 6224.0 6248.7 6257.2 6267.0 6268.0 6110.6 6193.0 6211.8 6269.7 6280.5 6169.7 6195.9 6205.0 6271.2 6287.4 5993.9 6176.8 6194.3 6194.6 6199.9 5108.4 5919.8 6214.8 6225.7 6234.8 6013.6 6051.7 6094.6 6112.4 6177.4 12:16:31 INFO - PROCESS | 1654 | 12:16:31 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:72346.12 Median:3431.68 stddev:159168.73 (4638.2%) stddev-sans-first:159523.76 12:16:31 INFO - PROCESS | 1654 | Values: 470.5 480.2 509.2 521.5 570.9 32285.0 42322.0 43732.9 44026.0 46206.3 45001.8 45245.0 45287.8 45395.8 45421.0 9525.2 9759.1 9766.0 9772.5 9774.2 8955.2 9220.1 11581.4 11841.8 11913.6 11845.5 11905.3 11926.8 11928.5 11961.0 11707.8 11776.6 11788.3 11807.2 11819.8 11715.9 11786.6 11798.4 11801.6 11804.8 42202.2 42270.0 42393.7 42527.6 42589.6 4049.5 4053.1 4100.8 4124.0 4136.6 30528.2 30959.0 32369.8 32775.7 33088.8 3227.7 3299.9 3347.8 3515.6 3552.8 514228.0 515135.0 515543.0 516804.0 517279.0 69516.7 70164.3 70219.0 70556.0 70566.9 72010.6 72179.6 72202.6 72229.6 72255.0 17199.9 17890.9 17894.6 17917.0 17963.2 12538.9 13740.7 13843.7 13880.9 13887.8 17102.5 17139.4 18192.4 22153.6 22319.3 8187.8 8299.7 8873.6 8916.5 9001.5 893.6 895.8 898.7 908.6 946.0 31715.5 31942.7 32186.0 32824.2 32829.9 975.8 1049.8 1061.6 1067.0 1088.6 14276.9 14728.6 14747.4 14803.8 15135.0 601592.0 694019.2 696551.0 698025.0 700185.0 48485.0 54097.0 56519.7 57261.7 57510.0 1346.9 1388.7 1397.6 1463.7 1502.3 26721.0 27544.8 30322.2 30541.7 30768.9 48930.3 49356.0 49387.8 49604.3 49665.0 574370.0 578742.0 579890.0 580150.0 580544.0 24327.9 24673.9 24709.1 24900.9 26492.7 37918.0 38237.9 42702.8 43592.6 43731.0 28215.4 30986.2 31423.0 32508.1 32567.0 30359.5 30851.5 30879.8 31722.7 31904.5 35674.6 36544.8 36865.8 36896.6 37064.6 30272.2 30923.5 31388.0 31570.8 32054.5 24525.5 24550.5 24663.2 24827.4 25012.6 12:16:31 INFO - PROCESS | 1654 | 12:16:31 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:41279.10 Median:21679.84 stddev:127640.89 (588.8%) stddev-sans-first:127962.05 12:16:31 INFO - PROCESS | 1654 | Values: 399.7 405.7 408.4 413.4 429.4 19158.6 20703.0 20918.3 21420.8 21938.9 22357.6 22445.1 23002.4 23318.3 23445.4 5944.2 6220.9 6260.8 6265.7 6284.9 5402.2 5731.1 6077.5 6108.7 6115.7 6061.4 6065.3 6073.1 6074.6 6081.3 5847.6 6046.0 6106.5 6116.4 6120.3 5388.9 5389.5 5395.1 5400.8 5498.4 10580.8 13917.6 14099.2 14114.9 14122.8 2688.3 2695.7 2700.5 2700.8 2710.4 10262.3 10529.6 10749.6 10778.2 11049.0 1833.4 1840.5 1864.9 1889.9 1890.3 130849.0 138252.3 140635.3 141883.0 143914.0 12028.2 12060.3 12259.9 12267.7 12458.9 16241.2 16280.5 16298.9 16313.9 16317.8 8317.1 8602.7 8664.8 8747.0 8776.6 8255.3 8271.1 8272.4 8392.5 8447.6 4922.7 4938.3 4942.9 4955.7 5097.9 2006.2 2045.2 2055.5 2056.0 2064.4 981.9 1013.7 1015.7 1021.1 1053.8 21288.8 22167.0 22221.6 22341.3 22372.8 1004.7 1010.0 1041.9 1042.2 1048.9 10255.9 10725.1 10848.9 11302.0 11307.3 742971.0 753398.0 768065.0 780027.0 785933.0 150913.0 152403.5 154364.0 157413.0 158513.0 1001.9 1014.1 1028.9 1032.0 1033.7 18883.4 19034.0 19494.9 19519.4 19570.7 55858.7 56477.4 57010.0 57058.7 58283.7 81790.0 84179.7 84404.6 85045.7 85145.3 8257.8 8305.4 8528.9 8885.7 8988.9 8298.0 13012.3 13453.5 13666.6 13885.3 11552.6 11779.7 11793.4 11850.9 11947.7 9387.3 9426.2 10519.1 10620.2 11115.2 11663.5 11875.9 11934.6 12059.5 12144.8 8511.2 8621.6 8696.9 8985.2 8988.0 10331.4 11083.5 11292.4 11392.7 11696.0 12:16:31 INFO - PROCESS | 1654 | 12:16:31 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5543.91 Median:5277.87 stddev:2997.88 (56.8%) stddev-sans-first:2989.03 12:16:31 INFO - PROCESS | 1654 | Values: 1264.0 1389.6 1486.7 1514.8 1529.4 7603.4 8064.0 8329.5 8556.1 8578.6 8362.6 8466.0 8491.6 8500.2 8542.1 2381.3 2415.2 2421.6 2427.0 2428.9 2001.2 2144.6 2218.9 2439.7 2448.4 2406.9 2407.7 2412.3 2413.4 2420.8 2357.9 2372.5 2396.8 2419.2 2422.4 2030.3 2400.6 2407.6 2430.8 2436.7 8508.3 8589.3 8600.3 8605.3 8608.4 5215.9 5360.5 5364.1 5367.4 5367.6 3397.6 3508.9 3561.7 3566.3 3570.2 1204.4 1249.9 1255.6 1302.9 1308.7 10863.5 10944.3 10954.3 10963.2 10994.2 4498.3 4697.4 4736.4 4840.6 4846.5 9610.9 9623.2 9631.4 9635.6 9643.5 5413.9 5415.9 5431.8 5432.6 5446.5 4490.8 4855.4 4905.8 4949.2 4960.1 3718.2 3815.4 3935.9 4013.3 4021.2 1161.4 1281.7 1295.7 1304.8 1305.5 905.0 915.7 930.0 944.4 989.3 5593.5 5605.4 5750.2 5869.6 5933.2 979.3 1011.2 1017.9 1029.4 1049.8 3337.9 3679.7 3726.7 3869.0 3902.8 9904.0 10132.3 10239.0 10257.2 10264.0 9910.9 9936.2 10189.9 10205.4 10222.2 8066.6 8134.5 8139.9 8152.9 8156.7 5539.7 5544.5 5601.3 5729.5 5769.7 9244.8 9458.5 9458.6 9464.6 9469.1 9274.9 9473.4 9474.1 9676.1 9689.0 7180.5 7276.7 7305.5 7362.3 7387.0 7319.6 7542.6 7703.8 7937.8 7967.2 6952.0 6994.8 7081.4 7124.3 7132.0 6946.3 6963.3 7002.2 7131.7 7165.4 6435.6 6492.0 6577.6 6587.3 6592.3 4950.3 4951.3 5066.7 5128.2 5239.9 5014.2 5089.3 5123.1 5151.8 5315.8 12:16:31 INFO - PROCESS | 1654 | 12:16:31 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4638.36 Median:5214.32 stddev:1414.36 (27.1%) stddev-sans-first:1381.53 12:16:31 INFO - PROCESS | 1654 | Values: 368.1 372.6 377.9 386.8 387.3 5186.2 5445.3 5461.3 5476.8 5493.3 4235.5 4661.0 5281.2 5304.7 5408.8 3694.1 4184.4 4199.2 4205.9 4298.6 3608.1 4257.6 4260.8 4270.1 4313.7 3523.0 4016.2 4270.1 4281.8 4286.8 4125.7 4220.3 4247.7 4263.2 4264.9 3749.0 3766.8 3791.4 3809.2 3845.2 4818.6 5249.6 5396.5 5409.9 5455.9 4201.1 4904.3 4919.5 4997.5 4998.0 4918.9 5023.7 5769.5 5795.6 5825.0 2789.3 4217.9 4227.5 4232.3 4241.6 5065.2 6066.7 6072.0 6085.9 6088.0 3636.5 4034.5 4040.4 4050.3 4061.0 4044.1 4073.9 4102.5 4126.2 4166.8 4016.1 4435.7 4667.2 4753.5 4760.9 5289.9 5371.8 5827.3 5841.3 5852.2 1311.4 1323.5 1329.5 1335.2 1353.5 751.4 767.5 788.0 846.5 849.7 5182.5 5203.2 5229.9 5244.5 5270.0 5343.5 5404.0 5476.6 5499.0 5763.7 4274.0 4438.2 4650.3 4850.6 5225.4 2389.5 2675.9 2859.7 2950.4 2958.5 5040.9 5447.6 5650.0 5653.5 5876.3 4900.9 5415.0 5707.6 5980.8 6044.3 5435.3 5623.6 6031.6 6144.3 6219.0 5261.3 5704.2 5767.0 5917.2 5968.5 5547.4 5587.7 5776.9 5841.7 5857.2 5478.8 5781.5 5969.9 6079.6 6106.1 3947.8 3993.5 4005.6 4030.7 4039.4 5617.2 5873.4 5970.4 5998.6 6005.9 5188.8 5199.5 5306.1 5681.8 5797.3 4950.5 5727.0 5751.5 5774.1 5841.8 4815.5 5635.4 5736.5 5749.4 5755.7 5052.1 5709.4 5718.5 5743.8 5838.0 4802.0 5660.9 5674.3 5712.3 5715.9 12:16:31 INFO - PROCESS | 1654 | 12:16:31 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:20779.29 Median:4151.20 stddev:29405.33 (708.4%) stddev-sans-first:29449.34 12:16:31 INFO - PROCESS | 1654 | Values: 744.0 763.4 792.9 854.6 870.3 15429.2 16065.5 16080.0 16091.7 16137.9 14600.2 14634.8 14719.0 14733.6 14740.2 704.3 878.0 889.6 891.4 891.7 680.7 693.6 697.5 723.4 725.9 946.8 948.1 948.6 952.9 954.6 943.6 945.1 945.4 946.9 947.1 703.2 703.2 703.7 704.9 706.6 13742.5 15092.2 15952.4 16008.6 16318.8 14720.2 14892.9 15162.4 15196.2 15350.0 11785.2 11800.9 11897.8 11945.3 12069.2 3783.6 3791.0 3817.0 3919.9 4052.8 85085.7 96800.5 104154.9 104549.0 108264.5 9835.9 10958.2 11491.4 11665.4 11737.2 24152.3 24671.6 24892.9 24898.6 24964.4 6651.4 8189.7 8199.7 8287.9 8358.2 4249.6 4403.9 4494.4 4503.8 4532.0 3501.3 3584.8 3589.0 3595.1 3597.2 662.1 675.9 696.2 698.9 699.2 643.3 658.5 676.0 677.6 687.7 9501.3 10077.8 10305.0 10437.7 10494.7 563.1 631.6 660.5 670.4 672.5 4934.2 4942.9 4964.5 4973.9 4979.6 104777.0 105600.5 108775.5 108835.9 112939.0 76530.6 79618.8 87157.0 89675.7 92446.1 53474.0 79326.6 82199.6 83864.0 84511.6 7773.3 9254.9 10468.9 10932.6 11305.3 51452.2 51896.4 51906.2 52365.0 52804.7 72003.6 72495.0 73445.6 73878.9 74183.0 13206.1 13382.7 13538.3 13992.7 14041.2 14954.0 14960.8 15365.3 15411.7 15990.0 13651.1 14047.5 14303.0 14381.0 14985.9 13509.7 13803.9 14349.7 14381.4 14456.7 13632.3 13969.7 14092.9 14153.1 14211.0 9784.4 9936.6 10092.5 10349.6 10405.3 9087.2 10855.2 11405.3 11427.3 11481.8 12:16:31 INFO - PROCESS | 1654 | -------- Summary: end -------- 12:16:31 INFO - PROCESS | 1654 | 12:16:32 INFO - TEST-INFO | 1654: exit 0 12:16:32 INFO - TEST-OK | dromaeo_css | took 1116701ms 12:16:32 INFO - TEST-START | kraken 12:16:32 INFO - operating with platform_type : mac_ 12:16:32 INFO - Initialising browser for kraken test... 12:16:32 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmp_S8dLS/profile http://localhost:49241/getInfo.html) 12:16:34 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 12:16:34 INFO - PROCESS | 1665 | colorDepth:24 12:16:34 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 12:16:34 INFO - PROCESS | 1665 | __metrics 12:16:34 INFO - PROCESS | 1665 | 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" 12:16:34 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:16:35 INFO - TEST-INFO | 1665: exit 0 12:16:35 INFO - Browser initialized. 12:16:35 INFO - Running cycle 1/1 for kraken test... 12:16:35 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmp_S8dLS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:47 INFO - PROCESS | 1667 | RSS: Main: 167682048 12:16:47 INFO - PROCESS | 1667 | 12:16:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 12:16:51 INFO - PROCESS | 1667 | RSS: Main: 215711744 12:16:51 INFO - PROCESS | 1667 | 12:16:53 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 12:16:54 INFO - PROCESS | 1667 | RSS: Main: 228438016 12:16:54 INFO - PROCESS | 1667 | 12:16:57 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 12:16:58 INFO - PROCESS | 1667 | RSS: Main: 325685248 12:16:58 INFO - PROCESS | 1667 | 12:17:00 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 12:17:00 INFO - PROCESS | 1667 | RSS: Main: 228433920 12:17:00 INFO - PROCESS | 1667 | 12:17:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:17:03 INFO - PROCESS | 1667 | RSS: Main: 228585472 12:17:03 INFO - PROCESS | 1667 | 12:17:06 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 12:17:06 INFO - PROCESS | 1667 | RSS: Main: 269733888 12:17:06 INFO - PROCESS | 1667 | 12:17:09 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 12:17:10 INFO - PROCESS | 1667 | RSS: Main: 270426112 12:17:10 INFO - PROCESS | 1667 | 12:17:13 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 12:17:13 INFO - PROCESS | 1667 | RSS: Main: 270299136 12:17:13 INFO - PROCESS | 1667 | 12:17:15 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:17:15 INFO - PROCESS | 1667 | RSS: Main: 245624832 12:17:15 INFO - PROCESS | 1667 | 12:17:17 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:17:18 INFO - PROCESS | 1667 | RSS: Main: 248152064 12:17:18 INFO - PROCESS | 1667 | 12:17:20 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:17:21 INFO - PROCESS | 1667 | RSS: Main: 256552960 12:17:21 INFO - PROCESS | 1667 | 12:17:24 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:17:24 INFO - PROCESS | 1667 | RSS: Main: 270761984 12:17:24 INFO - PROCESS | 1667 | 12:17:27 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:17:28 INFO - PROCESS | 1667 | RSS: Main: 264982528 12:17:28 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 12:17:30 INFO - PROCESS | 1667 | RSS: Main: 309121024 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | __start_tp_report 12:17:30 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 12:17:30 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 12:17:30 INFO - PROCESS | 1667 | |i|pagename|runs| 12:17:30 INFO - PROCESS | 1667 | |0;ai-astar;110;115;116;114;113;114;113;116;165;168 12:17:30 INFO - PROCESS | 1667 | |1;audio-beat-detection;143;105;106;138;120;128;106;106;124;105 12:17:30 INFO - PROCESS | 1667 | |2;audio-dft;182;187;194;255;205;184;185;181;185;184 12:17:30 INFO - PROCESS | 1667 | |3;audio-fft;80;57;58;86;59;59;57;59;89;77 12:17:30 INFO - PROCESS | 1667 | |4;audio-oscillator;81;68;85;69;69;68;81;66;67;80 12:17:30 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;91;88;90;89;90;86;91;87;90;86 12:17:30 INFO - PROCESS | 1667 | |6;imaging-darkroom;95;95;95;95;138;95;95;95;95;94 12:17:30 INFO - PROCESS | 1667 | |7;imaging-desaturate;85;86;88;88;85;87;85;85;85;88 12:17:30 INFO - PROCESS | 1667 | |8;json-parse-financial;52;52;51;53;56;54;54;55;56;55 12:17:30 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;62;80;111;104;89;67;69;69;70;70 12:17:30 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;85;83;84;81;84;78;80;79;86;89 12:17:30 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;142;139;148;136;134;134;136;143;183;154 12:17:30 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;168;169;163;162;213;212;164;159;160;154 12:17:30 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;63;64;65;64;64;66;74;78;81;79 12:17:30 INFO - PROCESS | 1667 | __end_tp_report 12:17:30 INFO - PROCESS | 1667 | __start_cc_report 12:17:30 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1978 12:17:30 INFO - PROCESS | 1667 | __end_cc_report 12:17:30 INFO - PROCESS | 1667 | __startTimestamp1491333450475__endTimestamp 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | ------- Summary: start ------- 12:17:30 INFO - PROCESS | 1667 | Number of tests: 14 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:124.40 Median:115.50 stddev:22.27 (19.3%) stddev-sans-first:23.00 12:17:30 INFO - PROCESS | 1667 | Values: 110.0 115.0 116.0 114.0 113.0 114.0 113.0 116.0 165.0 168.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:118.10 Median:122.00 stddev:14.66 (12.0%) stddev-sans-first:12.48 12:17:30 INFO - PROCESS | 1667 | Values: 143.0 105.0 106.0 138.0 120.0 128.0 106.0 106.0 124.0 105.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:194.20 Median:186.00 stddev:22.52 (12.1%) stddev-sans-first:23.45 12:17:30 INFO - PROCESS | 1667 | Values: 182.0 187.0 194.0 255.0 205.0 184.0 185.0 181.0 185.0 184.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:68.10 Median:68.00 stddev:13.23 (19.5%) stddev-sans-first:13.31 12:17:30 INFO - PROCESS | 1667 | Values: 80.0 57.0 58.0 86.0 59.0 59.0 57.0 59.0 89.0 77.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:73.40 Median:74.50 stddev:7.35 (9.9%) stddev-sans-first:7.26 12:17:30 INFO - PROCESS | 1667 | Values: 81.0 68.0 85.0 69.0 69.0 68.0 81.0 66.0 67.0 80.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:90.00 stddev:1.93 (2.1%) stddev-sans-first:1.88 12:17:30 INFO - PROCESS | 1667 | Values: 91.0 88.0 90.0 89.0 90.0 86.0 91.0 87.0 90.0 86.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:95.00 stddev:13.64 (14.4%) stddev-sans-first:14.38 12:17:30 INFO - PROCESS | 1667 | Values: 95.0 95.0 95.0 95.0 138.0 95.0 95.0 95.0 95.0 94.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.50 stddev:1.40 (1.6%) stddev-sans-first:1.41 12:17:30 INFO - PROCESS | 1667 | Values: 85.0 86.0 88.0 88.0 85.0 87.0 85.0 85.0 85.0 88.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.50 stddev:1.75 (3.2%) stddev-sans-first:1.73 12:17:30 INFO - PROCESS | 1667 | Values: 52.0 52.0 51.0 53.0 56.0 54.0 54.0 55.0 56.0 55.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:79.10 Median:69.50 stddev:16.82 (24.2%) stddev-sans-first:16.66 12:17:30 INFO - PROCESS | 1667 | Values: 62.0 80.0 111.0 104.0 89.0 67.0 69.0 69.0 70.0 70.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:84.00 stddev:3.41 (4.1%) stddev-sans-first:3.54 12:17:30 INFO - PROCESS | 1667 | Values: 85.0 83.0 84.0 81.0 84.0 78.0 80.0 79.0 86.0 89.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:142.50 stddev:14.86 (10.4%) stddev-sans-first:15.72 12:17:30 INFO - PROCESS | 1667 | Values: 142.0 139.0 148.0 136.0 134.0 134.0 136.0 143.0 183.0 154.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:166.00 stddev:21.57 (13.0%) stddev-sans-first:22.82 12:17:30 INFO - PROCESS | 1667 | Values: 168.0 169.0 163.0 162.0 213.0 212.0 164.0 159.0 160.0 154.0 12:17:30 INFO - PROCESS | 1667 | 12:17:30 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:7.30 (10.4%) stddev-sans-first:7.32 12:17:30 INFO - PROCESS | 1667 | Values: 63.0 64.0 65.0 64.0 64.0 66.0 74.0 78.0 81.0 79.0 12:17:30 INFO - PROCESS | 1667 | -------- Summary: end -------- 12:17:30 INFO - PROCESS | 1667 | 12:17:31 INFO - TEST-INFO | 1667: exit 0 12:17:31 INFO - TEST-OK | kraken | took 59227ms 12:17:31 INFO - SUITE-END | took 1175s 12:17:31 INFO - Completed test suite (00:19:36) 12:17:31 INFO - javascript benchmark 12:17:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3446.4485682290824, 3446.7414943879207, 3488.5464889564387, 3491.8254087295627, 3510.3330367230224, 5902.763889444423, 5923.970380148098, 5939.64362138272, 5956.4936980356615, 5972.761089556423, 5879.647221166733, 5903.0, 5984.670843103628, 5990.520758339333, 5996.8200953971345, 4023.7585744855255, 4972.676776009566, 5303.549198318147, 5385.084535628933, 5411.621186516945, 5285.550728188108, 5295.602829787781, 5302.655327403706, 5409.2967914171295, 5433.4566543345545, 5322.467753224666, 5342.439043900393, 5349.679019258838, 5399.83800485986, 5433.022056029913, 5391.946080539184, 5396.244525766376, 5403.918941215885, 5412.99859525987, 5414.187871819219, 5217.58259339252, 5277.577793776489, 5344.011357898801, 5363.973180134113, 5422.53908417785, 5780.017397042513, 5800.245968024172, 5872.970635146839, 5875.471207591295, 5895.675737834417, 6239.781607643756, 6266.624002559861, 6267.780627678009, 6274.592151510183, 6281.623102613812, 6218.22272215973, 6252.968735156341, 6264.436200741955, 6275.592086514408, 6276.215473065867, 5798.304203495565, 5907.2911250650195, 5916.674582897982, 5966.0, 5979.970100149559, 6274.341194174546, 6323.7786677466065, 6331.715072821734, 6343.9682801585695, 6347.333529979378, 6261.342559031327, 6296.307406185316, 6298.0, 6304.842378940563, 6305.211848518935, 6201.534884883652, 6259.436650701367, 6267.4986001120715, 6269.498440124779, 6275.341089185661, 6180.381961803783, 6184.226971628546, 6225.221847269091, 6241.438270555672, 6247.656378899113, 6247.156633854463, 6258.3428739982555, 6258.812235632939, 6268.968655156787, 6278.529110316745, 5054.1407960646775, 5063.822766203165, 5107.846764597068, 5113.258577506315, 5114.616403769732, 4531.56950089741, 4542.886427839265, 4550.13547425988, 4628.305754136839, 4629.213033784265, 4930.211166213388, 5885.3820348862755, 5906.7637294508595, 5964.1650168976375, 6025.367336429612, 6167.198264225622, 6201.875962480725, 6260.123582698426, 6261.812145635638, 6267.71795269214, 5715.342735585377, 5981.461668449861, 5994.130851026577, 6000.819975400745, 6006.729697163638, 5500.697461639648, 5517.44825517445, 5539.9169012464845, 5540.168974653753, 5558.527525160407, 6338.619682819046, 6414.743410263537, 6417.197850268716, 6432.2602900667025, 6451.903221451682, 6254.249490061222, 6261.96869015652, 6276.1213430118905, 6282.2147231596055, 6285.779997700059, 6233.252009758858, 6288.11966324724, 6289.245290565162, 6329.5252856036905, 6339.746410143543, 5509.47659972302, 6248.0, 6254.21822272216, 6255.874882502416, 6266.655333956676, 6224.037386163909, 6248.718807653758, 6257.1552840367785, 6267.0, 6268.0, 6110.5587591967305, 6193.0, 6211.844703882259, 6269.68651567429, 6280.528960328085, 6169.6915154241215, 6195.938040619536, 6205.0, 6271.184745982993, 6287.371262873676, 5993.921094202911, 6176.845578860564, 6194.287656919331, 6194.5973511721595, 6199.938000619936, 5108.386993560796, 5919.792807251725, 6214.782482613087, 6225.657588832477, 6234.781782637768, 6013.579049466671, 6051.667158306335, 6094.573379863367, 6112.407400958353, 6177.444030037318], "value": 5796.0267174388455, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.4730701614193, 480.1573238965616, 509.19038728421805, 521.5358331085334, 570.949453006468, 32285.031449056536, 42322.0, 43732.906677333085, 44025.999999999956, 46206.30690539636, 45001.77499112508, 45245.0, 45287.77356113223, 45395.773021134846, 45421.0, 9525.19035881951, 9759.121679048883, 9766.0, 9772.511374431286, 9774.218062555014, 8955.19403253707, 9220.124088211644, 11581.36302503362, 11841.822372664417, 11913.583024594142, 11845.526178952874, 11905.345206013666, 11926.7614647707, 11928.52285908567, 11961.0, 11707.765844683145, 11776.646700598996, 11788.29270243788, 11807.173497855196, 11819.763604727943, 11715.941420292844, 11786.646400607995, 11798.410079496076, 11801.586944456903, 11804.822927656092, 42202.155956881, 42270.0, 42393.728188154404, 42527.57472425298, 42589.57410425887, 4049.5343035550995, 4053.1285773558825, 4100.835966561334, 4123.958760412387, 4136.607022332873, 30528.236794080105, 30959.0, 32369.83815080933, 32775.6722432775, 33088.83455582731, 3227.7256433203206, 3299.884504042371, 3347.782394144373, 3515.5781306243157, 3552.7513074084823, 514228.0, 515135.0, 515542.9999999963, 516804.0, 517279.0, 69516.65241673759, 70164.2983570168, 70219.0, 70556.0, 70566.9414958776, 72010.63994679993, 72179.63910180521, 72202.63898680577, 72229.6388518054, 72255.0, 17199.91400043017, 17890.91054544745, 17894.55263618394, 17917.014564199093, 17963.191656375493, 12538.937305313415, 13740.65648358799, 13843.653908652162, 13880.930595347161, 13887.79168312476, 17102.48692539226, 17139.400120995706, 18192.363267285582, 22153.556928861333, 22319.330420087423, 8187.7718342247945, 8299.709510167237, 8873.556322183866, 8916.509591972374, 9001.504917229484, 893.629143905272, 895.785011597225, 898.7303808857316, 908.5502676175204, 946.0444950599943, 31715.52426713601, 31942.68057319397, 32186.0, 32824.179395515304, 32829.88315024514, 975.770693886936, 1049.800537897797, 1061.6496556136456, 1067.0, 1088.6135421925103, 14276.85723142776, 14728.55814325572, 14747.41010359595, 14803.777943330859, 15135.0, 601592.0, 694019.2392304251, 696551.0, 698025.0, 700185.0, 48485.0, 54097.0, 56519.71740141355, 57261.71369143211, 57510.0, 1346.8720471555187, 1388.6806034612096, 1397.6366144802425, 1463.721892840357, 1502.3089378885834, 26721.0, 27544.76048577859, 30322.241943951576, 30541.694583053886, 30768.923087692718, 48930.266046008626, 49356.0, 49387.75306123446, 49604.25593616171, 49665.00669986652, 574370.0, 578742.0, 579890.0, 580150.0, 580544.0, 24327.878360608083, 24673.87663061673, 24709.135180268604, 24900.875495622407, 26492.735072649026, 37918.0, 38237.85286441411, 42702.78648606737, 43592.56407436012, 43731.0, 28215.43569128565, 30986.225344366572, 31423.0, 32508.099028116776, 32567.0, 30359.544606831358, 30851.537226942062, 30879.845600771852, 31722.682773172895, 31904.521432179, 35674.64325356817, 36544.81727591345, 36865.815670921475, 36896.63103368932, 37064.62935370612, 30272.243193920327, 30923.536146958264, 31388.0, 31570.842145789124, 32054.519182211818, 24525.50948980975, 24550.50898982046, 24663.166929479372, 24827.379315517257, 25012.62481062749], "value": 20563.40411345644, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.6922369775271, 405.7362714235747, 408.4322791320064, 413.36961134270234, 429.44172575651663, 19158.616827663438, 20703.0, 20918.267860624863, 21420.785792142073, 21938.89030554847, 22357.55284894301, 22445.102195912186, 23002.42493937648, 23318.300450986455, 23445.41386465335, 5944.197533333009, 6220.875582488347, 6260.7808726694575, 6265.7493700251935, 6284.937150628503, 5402.243685883979, 5731.083026715726, 6077.544184186182, 6108.664023478706, 6115.663638499881, 6061.393860613947, 6065.302490213638, 6073.089036644516, 6074.605150665193, 6081.270247570298, 5847.5614328925285, 6045.969770151165, 6106.48094911933, 6116.357782432825, 6120.326764055995, 5388.91916621251, 5389.541888939445, 5395.136778115482, 5400.83797486076, 5498.422665620093, 10580.78838423235, 13917.58247252584, 14099.22454265015, 14114.85885141156, 14122.788158177636, 2688.314479807656, 2695.663042119735, 2700.4599080184043, 2700.7839372850126, 2710.417260289047, 10262.281640285182, 10529.631462898838, 10749.62376316825, 10778.191635627281, 11049.0, 1833.4499650104915, 1840.5122642499748, 1864.8787828791221, 1889.9338523151762, 1890.3383815664545, 130849.0, 138252.30873845666, 140635.29682351524, 141883.0, 143914.0, 12028.218165819193, 12060.336681482428, 12259.93870030662, 12267.69330766738, 12458.937705311597, 16241.187940603158, 16280.511584652479, 16298.918505407633, 16313.91843040801, 16317.836821631869, 8317.126701696356, 8602.698905538402, 8664.78338041554, 8747.0, 8776.648934042567, 8255.339572834158, 8271.090180080186, 8272.420930534925, 8392.454490458224, 8447.577621118919, 4922.680025798311, 4938.283948827472, 4942.851714448572, 4955.702657840469, 5097.8725531862, 2006.2476571285767, 2045.202371075282, 2055.496403381151, 2055.9588808223752, 2064.4013236161345, 981.9361741486781, 1013.6705570689555, 1015.7155996321042, 1021.1269364693229, 1053.8103141434462, 21288.78711212899, 22167.00248488822, 22221.555568888532, 22341.329760107223, 22372.776272237395, 1004.7186787699455, 1009.9697009089739, 1041.8697662792151, 1042.1766804224578, 1048.9108425783893, 10255.897441025494, 10725.088367488695, 10848.94575527133, 11302.039326657161, 11307.321560706385, 742971.0, 753398.0, 768065.0, 780027.0, 785933.0, 150913.0, 152403.47596524114, 154364.0, 157413.0, 158513.0, 1001.8998100189923, 1014.1278500489573, 1028.88682244953, 1032.0402026115635, 1033.6950599572995, 18883.433496995112, 19034.0, 19494.902525487283, 19519.414417567496, 19570.706439403704, 55858.720706396205, 56477.43522564722, 57010.0, 57058.7147064262, 58283.708581458515, 81790.0, 84179.73730393927, 84404.57797710971, 85045.7243141341, 85145.2687384477, 8257.752267431986, 8305.418620696493, 8528.914710852812, 8885.689000884939, 8988.86516702237, 8298.045724741733, 13012.28432436225, 13453.529126480526, 13666.590002299548, 13885.305734713425, 11552.573645036155, 11779.705507362385, 11793.351365674971, 11850.940745296219, 11947.745486724116, 9387.29595280343, 9426.182396129578, 10519.10587600032, 10620.150387969099, 11115.166362523005, 11663.533458661559, 11875.881241187477, 11934.641960741192, 12059.51761929548, 12144.75710485803, 8511.191436813493, 8621.568921553771, 8696.869546956674, 8985.191332780081, 8988.0, 10331.431771252654, 11083.526067865789, 11292.43537823122, 11392.715182120513, 11696.0], "value": 9964.741463750886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.0203842022438, 1389.562287879318, 1486.6952274783664, 1514.787929689843, 1529.3500262388482, 7603.35371493423, 8063.9596802015985, 8329.541875196854, 8556.058833528323, 8578.571071446433, 8362.58187090646, 8466.0, 8491.617877195526, 8500.192481714243, 8542.10307917669, 2381.261808839257, 2415.1667674652217, 2421.624648179535, 2426.9878650606724, 2428.890699918508, 2001.2195243854908, 2144.6246906791325, 2218.9112435502643, 2439.743826898177, 2448.424620214248, 2406.867622280774, 2407.6508906208587, 2412.3004328744732, 2413.372523143986, 2420.7579242075826, 2357.8938947747306, 2372.454335502827, 2396.772306630876, 2419.2137555294426, 2422.4186195313173, 2030.3198428526462, 2400.567897778399, 2407.5666380051584, 2430.7569243075727, 2436.7075950886006, 8508.276796472308, 8589.269912057483, 8600.268977136951, 8605.31157507398, 8608.39741218115, 5215.869603259911, 5360.517553420172, 5364.141737322048, 5367.382750983609, 5367.624266301361, 3397.59228892532, 3508.8946981700938, 3561.679448849616, 3566.3402270580027, 3570.1610121621397, 1204.3797444316185, 1249.93750312484, 1255.6484184428375, 1302.9087963842535, 1308.6597484654058, 10863.51114199863, 10944.343339399662, 10954.34273943558, 10963.232573719843, 10994.175436842188, 4498.347739577808, 4697.436307643105, 4736.407949006374, 4840.564349208517, 4846.491118432585, 9610.855837162448, 9623.230141588656, 9631.422114673142, 9635.56639951204, 9643.469609171563, 5413.944280865272, 5415.918761218585, 5431.755570999315, 5432.59255555827, 5446.482584154578, 4490.842820501267, 4855.368802055781, 4905.779239934212, 4949.232868905326, 4960.057589058068, 3718.200586873835, 3815.42768584709, 3935.9212815743526, 4013.257547353749, 4021.155557332993, 1161.4018780328138, 1281.7180220351509, 1295.7149427126017, 1304.8042793580848, 1305.4582348325528, 904.9592768325309, 915.7225670190047, 930.0, 944.419182202954, 989.302541708094, 5593.468620481048, 5605.355384130877, 5750.2237197978575, 5869.589128760946, 5933.169356290123, 979.2900147393083, 1011.1556850030161, 1017.9260879771912, 1029.3978022856713, 1049.8320268756963, 3337.89849349714, 3679.68722658577, 3726.7391282609956, 3868.9806550967064, 3902.8096430588375, 9904.009599040182, 10132.34139780912, 10238.9761023897, 10257.230707696803, 10264.0, 9910.900890991143, 9936.205103591696, 10189.949050254701, 10205.38767673942, 10222.182225421948, 8066.637001334954, 8134.471259368122, 8139.918600814034, 8152.8777068344025, 8156.714514991947, 5539.667619942817, 5544.473275038865, 5601.271834661468, 5729.512991395778, 5769.711514424178, 9244.768880777765, 9458.527073646152, 9458.574364153492, 9464.621415143318, 9469.053094690476, 9274.860877086714, 9473.384230025027, 9474.099960503741, 9676.080772326617, 9689.0, 7180.497365184387, 7276.745313914199, 7305.525140865827, 7362.3373896349585, 7386.963065184855, 7319.63401829917, 7542.622868856645, 7703.845923081395, 7937.801554961172, 7967.2431119043595, 6952.0, 6994.825129371807, 7081.433485321265, 7124.323189297009, 7132.037174981311, 6946.270641582561, 6963.268856770169, 7002.1947476040905, 7131.679074441558, 7165.390941770008, 6435.581687190505, 6491.961286194186, 6577.572457790228, 6587.308332625005, 6592.340765923369, 4950.331705219894, 4951.331570237971, 5066.72133032672, 5128.153854613947, 5239.921401178909, 5014.197728363444, 5089.338386009943, 5123.129068058364, 5151.768170432265, 5315.813946511854], "value": 4523.438269941556, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.09999551097565, 372.5734034530463, 377.901745546158, 386.7891998860621, 387.33765261403, 5186.247994040867, 5445.346558412991, 5461.290032295796, 5476.78092876285, 5493.313335833021, 4235.491740991078, 4660.9512859606575, 5281.174571604192, 5304.681719096857, 5408.810691625794, 3694.094946738053, 4184.414182014513, 4199.2441360555085, 4205.897051474263, 4298.634616057639, 3608.1160115771672, 4257.595528424795, 4260.786960651971, 4270.1459708058355, 4313.698041137121, 3523.0, 4016.1566071124953, 4270.0784646909015, 4281.764502952336, 4286.849960251392, 4125.711200216001, 4220.349397770921, 4247.681423893189, 4263.211305908386, 4264.914701705949, 3748.9812550937345, 3766.7551609145594, 3791.388659819566, 3809.1619843634357, 3845.192509572993, 4818.614510839125, 5249.553787928031, 5396.541293990015, 5409.891802163974, 5455.918161227585, 4201.122231271589, 4904.258988059223, 4919.508049195088, 4997.475265097185, 4997.950020499785, 4918.926216106761, 5023.66872778714, 5769.538436925036, 5795.565332600072, 5824.951508728427, 2789.330560665446, 4217.924429270547, 4227.471566054243, 4232.343986682069, 4241.600271910263, 5065.240213967897, 6066.664334231353, 6072.0, 6085.908711369333, 6087.969560152215, 3636.4545318201954, 4034.4755181826176, 4040.4141399496907, 4050.311447054008, 4060.9695152423787, 4044.1102957349335, 4073.91852162961, 4102.528209255974, 4126.236646220459, 4166.812493437742, 4016.1124271592303, 4435.667324950641, 4667.159911216014, 4753.47711751714, 4760.928586071212, 5289.894202116013, 5371.811986580451, 5827.329857066492, 5841.29078035442, 5852.180694702745, 1311.3770958794496, 1323.4970711129708, 1329.5413082486527, 1335.2122247873606, 1353.5465619017739, 751.3538357012965, 767.4574106046774, 787.9724209652635, 846.4667259626395, 849.7084431663836, 5182.481751824787, 5203.245529398292, 5229.92155117666, 5244.505315984926, 5270.0, 5343.519083282523, 5404.000259951921, 5476.561875049986, 5498.972505137529, 5763.740631671585, 4274.0, 4438.201123797748, 4650.302824361862, 4850.563449289581, 5225.399079105876, 2389.510150419195, 2675.906343277976, 2859.7140285971236, 2950.4099180164053, 2958.541426078961, 5040.924386134211, 5447.610859230871, 5649.971750141223, 5653.519450846642, 5876.268569458424, 4900.901981960341, 5415.014631125803, 5707.632496826892, 5980.820575382745, 6044.274687037584, 5435.342220622669, 5623.550115990711, 6031.642880351974, 6144.293406258248, 6219.0, 5261.289725886956, 5704.229928959538, 5766.971165144315, 5917.230760001345, 5968.46283834457, 5547.44525547442, 5587.664740115606, 5776.855578610568, 5841.678707671119, 5857.242827151923, 5478.780848766164, 5781.4968108291305, 5969.852641619965, 6079.592295585665, 6106.053561697944, 3947.782871942071, 3993.5008123984503, 4005.619466150711, 4030.6573941215324, 4039.4142849287277, 5617.241672374177, 5873.353931067493, 5970.373110823475, 5998.550108741949, 6005.948958932082, 5188.766505507186, 5199.506046925536, 5306.071437498345, 5681.77272909079, 5797.275340582427, 4950.45544990058, 5727.0, 5751.4536119068625, 5774.105013722879, 5841.824745257649, 4815.518448155157, 5635.380108188014, 5736.483716465538, 5749.396313387034, 5755.668954073607, 5052.065367906949, 5709.3719690834805, 5718.456746609066, 5743.770249189985, 5838.0, 4801.95198048029, 5660.915086273627, 5674.2623458950075, 5712.314522257356, 5715.942550628147], "value": 4194.503639853277, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.9510636717102, 763.435058057038, 792.9405294602906, 854.6410507586813, 870.3124531620018, 15429.151396673178, 16065.518034458984, 16080.0, 16091.678166436664, 16137.919310403446, 14600.196989165592, 14634.780478292807, 14719.04326218795, 14733.631659208499, 14740.189289589069, 704.3484776581668, 877.9648814047447, 889.5685592487638, 891.4428482198626, 891.7012800711769, 680.6936878404713, 693.6323748413349, 697.5082566790426, 723.4104205072849, 725.8802297620887, 946.8248374050788, 948.0614191949954, 948.6395169835453, 952.9142377186051, 954.5990683912738, 943.5753910740194, 945.0596656326929, 945.3902233059672, 946.9384490008127, 947.0718695678205, 703.1597241296653, 703.1632357494565, 703.714995426853, 704.8660754456688, 706.6007705646344, 13742.519011834538, 15092.245387730569, 15952.361905523765, 16008.599785005468, 16318.776091793163, 14720.190389528572, 14892.925535372255, 15162.393504259817, 15196.164210968393, 15350.0, 11785.175037747362, 11800.90768540219, 11897.762044759056, 11945.343006134659, 12069.215500992408, 3783.564890037653, 3791.0332865119494, 3816.9809150954065, 3919.902002449933, 4052.7770972596495, 85085.72371414433, 96800.51599742027, 104154.9169016623, 104549.0, 108264.45867770689, 9835.901640983499, 10958.18496084945, 11491.3679747613, 11665.358405287621, 11737.178397512263, 24152.275431737075, 24671.62992555113, 24892.875535622206, 24898.626520602207, 24964.375890602518, 6651.368120028589, 8189.7133600323705, 8199.672013119527, 8287.875681864776, 8358.205970432798, 4249.617534421917, 4403.867883963422, 4494.4157259556705, 4503.752293623882, 4531.954680453153, 3501.2647344057523, 3584.8386822593047, 3588.9820550897603, 3595.065283026432, 3597.1546686528645, 662.1170896583886, 675.864827034595, 696.154172680196, 698.9266127056687, 699.1610067918416, 643.2859525926218, 658.5127006015514, 675.9662016899135, 677.6306912732573, 687.7214728035153, 9501.287403444769, 10077.798444031077, 10305.021023002802, 10437.68686939393, 10494.73763155912, 563.0580218359041, 631.5673763472037, 660.5277226782873, 670.4267850987433, 672.5090683800853, 4934.235193545006, 4942.9258561121615, 4964.528369804862, 4973.925391119136, 4979.576735977483, 104776.95223047672, 105600.47199763951, 108775.45612271888, 108835.91164088417, 112939.0, 76530.61734691402, 79618.80571791428, 87157.0, 89675.65486517578, 92446.0755392451, 53474.00645055535, 79326.60336698279, 82199.5890020546, 83864.0, 84511.5774421124, 7773.3004029637605, 9254.93568239661, 10468.947655261674, 10932.617358392417, 11305.26515776472, 51452.22821657753, 51896.42885422554, 51906.221406678174, 52365.0, 52804.73597631987, 72003.63998179976, 72495.0, 73445.63277183793, 73878.89181662387, 74183.0, 13206.075574709677, 13382.732794128022, 13538.323083845966, 13992.650183745081, 14041.227732474403, 14954.0, 14960.821627852478, 15365.308561114553, 15411.691766164839, 15990.0, 13651.11267767592, 14047.508337208148, 14303.0, 14381.0, 14985.850141498882, 13509.716576925177, 13803.930980345034, 14349.713005740035, 14381.352839122055, 14456.710865782416, 13632.318384080558, 13969.650758731113, 14092.859071409155, 14153.08004979673, 14211.005229633827, 9784.364016338915, 9936.602535898483, 10092.495375231356, 10349.586016559253, 10405.271630985759, 9087.182153605943, 10855.185861060294, 11405.258658187191, 11427.257228280136, 11481.770364592829], "value": 7661.756601828687, "unit": "score"}], "name": "dromaeo_css", "value": 7462.241151197187, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 116.0, 114.0, 113.0, 114.0, 113.0, 116.0, 165.0, 168.0], "value": 124.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 105.0, 106.0, 138.0, 120.0, 128.0, 106.0, 106.0, 124.0, 105.0], "value": 118.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 187.0, 194.0, 255.0, 205.0, 184.0, 185.0, 181.0, 185.0, 184.0], "value": 194.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 58.0, 86.0, 59.0, 59.0, 57.0, 59.0, 89.0, 77.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 68.0, 85.0, 69.0, 69.0, 68.0, 81.0, 66.0, 67.0, 80.0], "value": 73.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 90.0, 89.0, 90.0, 86.0, 91.0, 87.0, 90.0, 86.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 138.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 88.0, 88.0, 85.0, 87.0, 85.0, 85.0, 85.0, 88.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 53.0, 56.0, 54.0, 54.0, 55.0, 56.0, 55.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 80.0, 111.0, 104.0, 89.0, 67.0, 69.0, 69.0, 70.0, 70.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 81.0, 84.0, 78.0, 80.0, 79.0, 86.0, 89.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 148.0, 136.0, 134.0, 134.0, 136.0, 143.0, 183.0, 154.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 163.0, 162.0, 213.0, 212.0, 164.0, 159.0, 160.0, 154.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 64.0, 64.0, 66.0, 74.0, 78.0, 81.0, 79.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1455.3000000000002, "alertThreshold": 2.0}]} 12:17:31 INFO - Return code: 0 12:17:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:17:31 INFO - # TBPL SUCCESS # 12:17:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:17:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:17:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:17:31 INFO - 2017-04-04 12:17:31.767 screenresolution[1671:9889] starting screenresolution argv=screenresolution get 12:17:31 INFO - 2017-04-04 12:17:31.770 screenresolution[1671:9889] Display 0: 1600x1200x32@60 12:17:31 INFO - 2017-04-04 12:17:31.776 screenresolution[1672:9892] starting screenresolution argv=screenresolution list 12:17:31 INFO - Available Modes on Display 0 12:17:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:17:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:17:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:17:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:17:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:17:32 INFO - Intel Iris: 12:17:32 INFO - Chipset Model: Intel Iris 12:17:32 INFO - Type: GPU 12:17:32 INFO - Bus: Built-In 12:17:32 INFO - VRAM (Dynamic, Max): 1536 MB 12:17:32 INFO - Vendor: Intel (0x8086) 12:17:32 INFO - Device ID: 0x0a2e 12:17:32 INFO - Revision ID: 0x0009 12:17:32 INFO - Displays: 12:17:32 INFO - Display: 12:17:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:17:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:17:32 INFO - Display Serial Number: 1600x1200 60 12:17:32 INFO - Main Display: Yes 12:17:32 INFO - Mirror: Off 12:17:32 INFO - Online: Yes 12:17:32 INFO - Rotation: Supported 12:17:32 INFO - Return code: 0 12:17:32 INFO - Running post-action listener: _resource_record_post_action 12:17:32 INFO - [mozharness: 2017-04-04 19:17:32.016205Z] Finished run-tests step (success) 12:17:32 INFO - Running post-run listener: _resource_record_post_run 12:17:32 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 39150592; Write bytes: 420611072; Read time: 255; Write time: 1370 12:17:32 INFO - TinderboxPrint: CPU usage
54.0% 12:17:32 INFO - TinderboxPrint: I/O read bytes / time
39,150,592 / 255 12:17:32 INFO - TinderboxPrint: I/O write bytes / time
420,611,072 / 1,370 12:17:32 INFO - TinderboxPrint: CPU idle
2,193.3 (46.0%) 12:17:32 INFO - TinderboxPrint: CPU system
961.1 (20.2%) 12:17:32 INFO - TinderboxPrint: CPU user
1,611.2 (33.8%) 12:17:32 INFO - TinderboxPrint: Swap in / out
159,772,672 / 0 12:17:32 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122798592; Write bytes: 122466304; Read time: 11180; Write time: 279 12:17:32 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 35316736; Write bytes: 296604672; Read time: 231; Write time: 1085 12:17:32 INFO - Running post-run listener: _upload_blobber_files 12:17:32 INFO - Blob upload gear active. 12:17:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:17:32 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 12:17:32 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'] 12:17:32 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 12:17:32 INFO - (blobuploader) - INFO - Open directory for files ... 12:17:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:17:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:17:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:34 INFO - (blobuploader) - INFO - Done attempting. 12:17:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:17:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:17:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:34 INFO - (blobuploader) - INFO - Done attempting. 12:17:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:17:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:17:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:35 INFO - (blobuploader) - INFO - Done attempting. 12:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:17:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:37 INFO - (blobuploader) - INFO - Done attempting. 12:17:37 INFO - (blobuploader) - INFO - Iteration through files over. 12:17:37 INFO - Return code: 0 12:17:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:17:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:17:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/27317dd5383051b2fe7c16661ebbb229d6067451c9aef06b6fe3d7fb881d97db7317b8a60e8af1355e4c4de84a56570f194770a78c81e526888a523535ed0b30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1bcad77fb8f82ccfd4d22b3753eec51e6e0d78ac498c2a6f31b3b0091d1ccc1c9ce9aa540a00aca5f25007fb22f68d47e001d94309de9d6170a48f75f74dc2ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ba8990c0a454bb6b16394ba9875537758a884fc94e81fd59b9c4175f325c50bf92933e783c2e8605ff576feea7aeb5874996bfb1c0e756886ac69aee45f7caf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adde6762f863123f535a699a4709e8200a013b104d7ea79afc14b7f6fc7986386b2773850a3812e43bdc83153c014c3ffb7be5d6c63faa8939b0397fdc643b2e"} 12:17:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:17:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:17:37 INFO - Contents: 12:17:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/27317dd5383051b2fe7c16661ebbb229d6067451c9aef06b6fe3d7fb881d97db7317b8a60e8af1355e4c4de84a56570f194770a78c81e526888a523535ed0b30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1bcad77fb8f82ccfd4d22b3753eec51e6e0d78ac498c2a6f31b3b0091d1ccc1c9ce9aa540a00aca5f25007fb22f68d47e001d94309de9d6170a48f75f74dc2ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ba8990c0a454bb6b16394ba9875537758a884fc94e81fd59b9c4175f325c50bf92933e783c2e8605ff576feea7aeb5874996bfb1c0e756886ac69aee45f7caf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adde6762f863123f535a699a4709e8200a013b104d7ea79afc14b7f6fc7986386b2773850a3812e43bdc83153c014c3ffb7be5d6c63faa8939b0397fdc643b2e"} 12:17:37 INFO - Running post-run listener: copy_logs_to_upload_dir 12:17:37 INFO - Copying logs to upload dir... 12:17:37 INFO - mkdir: /builds/slave/test/build/upload/logs 12:17:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.374080 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-04-04 12:17:38.044006) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 12:17:38.047411) ========= 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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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/27317dd5383051b2fe7c16661ebbb229d6067451c9aef06b6fe3d7fb881d97db7317b8a60e8af1355e4c4de84a56570f194770a78c81e526888a523535ed0b30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1bcad77fb8f82ccfd4d22b3753eec51e6e0d78ac498c2a6f31b3b0091d1ccc1c9ce9aa540a00aca5f25007fb22f68d47e001d94309de9d6170a48f75f74dc2ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ba8990c0a454bb6b16394ba9875537758a884fc94e81fd59b9c4175f325c50bf92933e783c2e8605ff576feea7aeb5874996bfb1c0e756886ac69aee45f7caf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adde6762f863123f535a699a4709e8200a013b104d7ea79afc14b7f6fc7986386b2773850a3812e43bdc83153c014c3ffb7be5d6c63faa8939b0397fdc643b2e"} build_url:https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011005 build_url: 'https://queue.taskcluster.net/v1/task/E0pUGjDNRBCw-XQpikayqQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/27317dd5383051b2fe7c16661ebbb229d6067451c9aef06b6fe3d7fb881d97db7317b8a60e8af1355e4c4de84a56570f194770a78c81e526888a523535ed0b30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1bcad77fb8f82ccfd4d22b3753eec51e6e0d78ac498c2a6f31b3b0091d1ccc1c9ce9aa540a00aca5f25007fb22f68d47e001d94309de9d6170a48f75f74dc2ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ba8990c0a454bb6b16394ba9875537758a884fc94e81fd59b9c4175f325c50bf92933e783c2e8605ff576feea7aeb5874996bfb1c0e756886ac69aee45f7caf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adde6762f863123f535a699a4709e8200a013b104d7ea79afc14b7f6fc7986386b2773850a3812e43bdc83153c014c3ffb7be5d6c63faa8939b0397fdc643b2e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 12:17:38.086085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:17:38.086640) ========= 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.HL9mdDi3BN/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.aIz5OlGAyM/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.004445 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:17:38.138089) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 12:17:38.138776) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 12:17:38.139510) ========= ========= Total master_lag: 0.28 =========