builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0100 starttime: 1492794577.93 results: success (0) buildid: 20170421084120 builduid: 1c391f3310904a7baa1d4022a9db8cc2 revision: 188cc9e6d18d8dff122b0190e19c1e658b6d0f29 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 10:09:37.925745) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 10:09:37.926218) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 10:09:37.926504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 10:09:37.953951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:09:37.954349) ========= 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.L9PsZFii3s/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.QJeTRj7ECk/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-21 10:09:37-- 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% 13.7M=0.001s 2017-04-21 10:09:38 (13.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122834 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:09:38.102636) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:09:38.102987) ========= 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.L9PsZFii3s/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.QJeTRj7ECk/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.028972 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:09:38.155318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 10:09:38.155888) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 188cc9e6d18d8dff122b0190e19c1e658b6d0f29 --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 188cc9e6d18d8dff122b0190e19c1e658b6d0f29 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L9PsZFii3s/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.QJeTRj7ECk/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-21 10:09:38,259 truncating revision to first 12 chars 2017-04-21 10:09:38,259 Setting DEBUG logging. 2017-04-21 10:09:38,259 attempt 1/10 2017-04-21 10:09:38,259 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/188cc9e6d18d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 10:09:39,592 unpacking tar archive at: mozilla-beta-188cc9e6d18d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.611481 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 10:09:39.792692) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 10:09:39.793044) ========= script_repo_revision: 188cc9e6d18d8dff122b0190e19c1e658b6d0f29 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 10:09:39.793465) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 10:09:39.793745) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 10:09:39.814286) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-04-21 10:09:39.814688) ========= /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.L9PsZFii3s/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.QJeTRj7ECk/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 10:09:40 INFO - MultiFileLogger online at 20170421 10:09:40 in /builds/slave/test 10:09:40 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 10:09:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:09:40 INFO - {'append_to_log': False, 10:09:40 INFO - 'base_work_dir': '/builds/slave/test', 10:09:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:09:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:09:40 INFO - 'branch': 'Mozilla-Beta', 10:09:40 INFO - 'buildbot_json_path': 'buildprops.json', 10:09:40 INFO - 'config_files': ('talos/mac_config.py',), 10:09:40 INFO - 'default_actions': ('clobber', 10:09:40 INFO - 'read-buildbot-config', 10:09:40 INFO - 'download-and-extract', 10:09:40 INFO - 'populate-webroot', 10:09:40 INFO - 'create-virtualenv', 10:09:40 INFO - 'install', 10:09:40 INFO - 'run-tests'), 10:09:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:09:40 INFO - 'download_minidump_stackwalk': True, 10:09:40 INFO - 'download_symbols': 'ondemand', 10:09:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:09:40 INFO - 'tooltool.py': '/tools/tooltool.py', 10:09:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:09:40 INFO - '/tools/misc-python/virtualenv.py')}, 10:09:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:09:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:09:40 INFO - 'gecko_profile': False, 10:09:40 INFO - 'gecko_profile_interval': 0, 10:09:40 INFO - 'installer_path': 'installer.exe', 10:09:40 INFO - 'log_level': 'info', 10:09:40 INFO - 'log_name': 'talos', 10:09:40 INFO - 'log_to_console': True, 10:09:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:09:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:09:40 INFO - 'opt_config_files': (), 10:09:40 INFO - 'pip_index': False, 10:09:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:09:40 INFO - 'cmd': ('bash', 10:09:40 INFO - '-c', 10:09:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:09:40 INFO - 'enabled': True, 10:09:40 INFO - 'halt_on_failure': False, 10:09:40 INFO - 'name': 'check_screen_resolution'},), 10:09:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:09:40 INFO - 'cmd': ('bash', 10:09:40 INFO - '-c', 10:09:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:09:40 INFO - 'enabled': True, 10:09:40 INFO - 'halt_on_failure': False, 10:09:40 INFO - 'name': 'check_screen_resolution'},), 10:09:40 INFO - 'run_cmd_checks_enabled': True, 10:09:40 INFO - 'suite': 'dromaeojs', 10:09:40 INFO - 'system_bits': '32', 10:09:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:09:40 INFO - 'title': 't-yosemite-r7-0100', 10:09:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:09:40 INFO - 'use_talos_json': True, 10:09:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:09:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:09:40 INFO - 'work_dir': 'build'} 10:09:40 INFO - [mozharness: 2017-04-21 17:09:40.031358Z] Running clobber step. 10:09:40 INFO - Running pre-action listener: _resource_record_pre_action 10:09:40 INFO - Running main action method: clobber 10:09:40 INFO - rmtree: /builds/slave/test/build 10:09:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:09:41 INFO - Running post-action listener: _resource_record_post_action 10:09:41 INFO - [mozharness: 2017-04-21 17:09:41.456238Z] Finished clobber step (success) 10:09:41 INFO - [mozharness: 2017-04-21 17:09:41.456420Z] Running read-buildbot-config step. 10:09:41 INFO - Running pre-action listener: _resource_record_pre_action 10:09:41 INFO - Running main action method: read_buildbot_config 10:09:41 INFO - Using buildbot properties: 10:09:41 INFO - { 10:09:41 INFO - "project": "", 10:09:41 INFO - "product": "firefox", 10:09:41 INFO - "script_repo_revision": "production", 10:09:41 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:09:41 INFO - "repository": "", 10:09:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:09:41 INFO - "buildid": "20170421084120", 10:09:41 INFO - "pgo_build": "False", 10:09:41 INFO - "basedir": "/builds/slave/test", 10:09:41 INFO - "buildnumber": 14, 10:09:41 INFO - "slavename": "t-yosemite-r7-0100", 10:09:41 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:09:41 INFO - "platform": "yosemite_r7", 10:09:41 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:09:41 INFO - "branch": "mozilla-beta", 10:09:41 INFO - "repo_path": "releases/mozilla-beta", 10:09:41 INFO - "revision": "188cc9e6d18d8dff122b0190e19c1e658b6d0f29", 10:09:41 INFO - "stage_platform": "macosx64", 10:09:41 INFO - "builduid": "1c391f3310904a7baa1d4022a9db8cc2", 10:09:41 INFO - "slavebuilddir": "test" 10:09:41 INFO - } 10:09:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 10:09:41 INFO - Running post-action listener: _resource_record_post_action 10:09:41 INFO - [mozharness: 2017-04-21 17:09:41.460838Z] Finished read-buildbot-config step (success) 10:09:41 INFO - [mozharness: 2017-04-21 17:09:41.460997Z] Running download-and-extract step. 10:09:41 INFO - Running pre-action listener: _resource_record_pre_action 10:09:41 INFO - Running main action method: download_and_extract 10:09:41 INFO - mkdir: /builds/slave/test/build/tests 10:09:41 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')]} 10:09:41 INFO - trying https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 10:09:41 INFO - Downloading https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 10:09:42 INFO - Downloaded 1165 bytes. 10:09:42 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:09:42 INFO - Using the following test package requirements: 10:09:42 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:09:42 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:09:42 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 10:09:42 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:09:42 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 10:09:42 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:09:42 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:09:42 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 10:09:42 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:09:42 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:09:42 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 10:09:42 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:09:42 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 10:09:42 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:09:42 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 10:09:42 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:09:42 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 10:09:42 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 10:09:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:09:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:09:42 INFO - Fetch https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:09:43 INFO - Expected file size: 51220748 10:09:43 INFO - Obtained file size: 51220748 10:09:59 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:09:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:09:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:09:59 INFO - Fetch https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:10:01 INFO - Expected file size: 51220748 10:10:01 INFO - Obtained file size: 51220748 10:10:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 10:10:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 10:10:16 INFO - Fetch https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 10:10:17 INFO - Expected file size: 14404424 10:10:17 INFO - Obtained file size: 14404424 10:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:18 INFO - trying https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:10:18 INFO - Downloading https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 10:10:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 10:10:19 INFO - Downloaded 59543571 bytes. 10:10:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:10:19 INFO - mkdir: /builds/slave/test/properties 10:10:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:10:19 INFO - Writing to file /builds/slave/test/properties/build_url 10:10:19 INFO - Contents: 10:10:19 INFO - build_url:https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:10:20 INFO - Running post-action listener: _resource_record_post_action 10:10:20 INFO - Running post-action listener: set_extra_try_arguments 10:10:20 INFO - [mozharness: 2017-04-21 17:10:20.587451Z] Finished download-and-extract step (success) 10:10:20 INFO - [mozharness: 2017-04-21 17:10:20.587598Z] Running populate-webroot step. 10:10:20 INFO - Running pre-action listener: _resource_record_pre_action 10:10:20 INFO - Running main action method: populate_webroot 10:10:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:10:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:10:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:10:20 INFO - '--tppagecycles', 10:10:20 INFO - '7'], 10:10:20 INFO - 'tests': ['tsvgm']}}, 10:10:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:10:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:10:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:10:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:10:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:10:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:10:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:10:20 INFO - 'talos_options': ['--disable-e10s'], 10:10:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:10:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:10:20 INFO - 'talos_options': ['--disable-e10s'], 10:10:20 INFO - 'tests': ['damp', 'tps']}, 10:10:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:10:20 INFO - 'tests': ['damp', 'tps']}, 10:10:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:10:20 INFO - 'tests': ['dromaeo_dom']}, 10:10:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:10:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:10:20 INFO - 'tests': ['basic_compositor_video']}, 10:10:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:10:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:10:20 INFO - 'tests': ['a11yr', 10:10:20 INFO - 'ts_paint', 10:10:20 INFO - 'tpaint', 10:10:20 INFO - 'sessionrestore', 10:10:20 INFO - 'sessionrestore_no_auto_restore', 10:10:20 INFO - 'tabpaint']}, 10:10:20 INFO - 'other-e10s': {'tests': ['a11yr', 10:10:20 INFO - 'ts_paint', 10:10:20 INFO - 'tpaint', 10:10:20 INFO - 'sessionrestore', 10:10:20 INFO - 'sessionrestore_no_auto_restore', 10:10:20 INFO - 'tabpaint']}, 10:10:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:10:20 INFO - 'ts_paint', 10:10:20 INFO - 'tpaint', 10:10:20 INFO - 'sessionrestore', 10:10:20 INFO - 'sessionrestore_no_auto_restore', 10:10:20 INFO - 'tabpaint']}, 10:10:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:10:20 INFO - 'ts_paint', 10:10:20 INFO - 'tpaint', 10:10:20 INFO - 'sessionrestore', 10:10:20 INFO - 'sessionrestore_no_auto_restore', 10:10:20 INFO - 'tabpaint']}, 10:10:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:10:20 INFO - 'tests': ['a11yr', 10:10:20 INFO - 'ts_paint', 10:10:20 INFO - 'tpaint', 10:10:20 INFO - 'sessionrestore', 10:10:20 INFO - 'sessionrestore_no_auto_restore', 10:10:20 INFO - 'tabpaint']}, 10:10:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:10:20 INFO - 'tests': ['a11yr', 10:10:20 INFO - 'ts_paint', 10:10:20 INFO - 'tpaint', 10:10:20 INFO - 'sessionrestore', 10:10:20 INFO - 'sessionrestore_no_auto_restore', 10:10:20 INFO - 'tabpaint']}, 10:10:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:10:20 INFO - 'tests': ['tsvgx', 10:10:20 INFO - 'tsvgr_opacity', 10:10:20 INFO - 'tart', 10:10:20 INFO - 'tscrollx', 10:10:20 INFO - 'cart', 10:10:20 INFO - 'tsvg_static']}, 10:10:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:10:20 INFO - 'tsvgr_opacity', 10:10:20 INFO - 'tart', 10:10:20 INFO - 'tscrollx', 10:10:20 INFO - 'cart', 10:10:20 INFO - 'tsvg_static']}, 10:10:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:10:20 INFO - 'talos_options': ['--disable-e10s'], 10:10:20 INFO - 'tests': ['tp5o']}, 10:10:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:10:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:10:20 INFO - 'talos_options': ['--disable-e10s', 10:10:20 INFO - '--xperf_path', 10:10:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:20 INFO - 'tests': ['tp5n']}, 10:10:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:10:20 INFO - 'talos_options': ['--xperf_path', 10:10:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:20 INFO - 'tests': ['tp5n']}}, 10:10:20 INFO - 'talos.zip': {'path': '', 10:10:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:10:20 INFO - Running post-action listener: _resource_record_post_action 10:10:20 INFO - [mozharness: 2017-04-21 17:10:20.606068Z] Finished populate-webroot step (success) 10:10:20 INFO - [mozharness: 2017-04-21 17:10:20.606200Z] Running create-virtualenv step. 10:10:20 INFO - Running pre-action listener: _resource_record_pre_action 10:10:20 INFO - Running main action method: create_virtualenv 10:10:20 INFO - Creating virtualenv /builds/slave/test/build/venv 10:10:20 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 10:10:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:10:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:10:20 INFO - Using real prefix '/tools/python27' 10:10:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:10:21 INFO - Installing distribute.............................................................................................................................................................................................done. 10:10:24 INFO - Installing pip.................done. 10:10:24 INFO - Return code: 0 10:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:10:24 INFO - Reading from file tmpfile_stdout 10:10:24 INFO - Output received: 10:10:24 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) 10:10:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:10:24 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')]} 10:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:24 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')]} 10:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:24 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 0x10c732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7bd85e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c510d30>, '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 0x10c437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c505be8>, '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.L9PsZFii3s/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.QJeTRj7ECk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 10:10:24 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 10:10:24 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 10:10:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9PsZFii3s/Render', 10:10:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:24 INFO - 'HOME': '/Users/cltbld', 10:10:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:24 INFO - 'LOGNAME': 'cltbld', 10:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:24 INFO - 'MOZ_NO_REMOTE': '1', 10:10:24 INFO - 'NO_EM_RESTART': '1', 10:10:24 INFO - 'PAGER': '/bin/cat', 10:10:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:24 INFO - 'PWD': '/builds/slave/test', 10:10:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:24 INFO - 'SHELL': '/bin/bash', 10:10:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJeTRj7ECk/Listeners', 10:10:24 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 10:10:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:24 INFO - 'USER': 'cltbld', 10:10:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:24 INFO - 'XPC_FLAGS': '0x0', 10:10:24 INFO - 'XPC_SERVICE_NAME': '0', 10:10:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:24 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 10:10:24 INFO - Cleaning up... 10:10:24 INFO - Return code: 0 10:10:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:10:24 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')]} 10:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:24 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')]} 10:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:24 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 0x10c732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7bd85e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c510d30>, '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 0x10c437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c505be8>, '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.L9PsZFii3s/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.QJeTRj7ECk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 10:10:24 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 10:10:24 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 10:10:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9PsZFii3s/Render', 10:10:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:24 INFO - 'HOME': '/Users/cltbld', 10:10:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:24 INFO - 'LOGNAME': 'cltbld', 10:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:24 INFO - 'MOZ_NO_REMOTE': '1', 10:10:24 INFO - 'NO_EM_RESTART': '1', 10:10:24 INFO - 'PAGER': '/bin/cat', 10:10:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:24 INFO - 'PWD': '/builds/slave/test', 10:10:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:24 INFO - 'SHELL': '/bin/bash', 10:10:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJeTRj7ECk/Listeners', 10:10:24 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 10:10:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:24 INFO - 'USER': 'cltbld', 10:10:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:24 INFO - 'XPC_FLAGS': '0x0', 10:10:24 INFO - 'XPC_SERVICE_NAME': '0', 10:10:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:25 INFO - Downloading/unpacking psutil>=3.1.1 10:10: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 10:10: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 10:10: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 10:10: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 10:10: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 10:10: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 10:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:10:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:28 INFO - Installing collected packages: psutil 10:10:28 INFO - Running setup.py install for psutil 10:10:28 INFO - building 'psutil._psutil_osx' extension 10:10:28 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 10:10:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:10:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:10:29 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 10:10:29 INFO - building 'psutil._psutil_posix' extension 10:10:29 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 10:10:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:10:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:10:29 INFO - ^ 10:10:29 INFO - 1 warning generated. 10:10:29 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 10:10:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:29 INFO - Successfully installed psutil 10:10:29 INFO - Cleaning up... 10:10:29 INFO - Return code: 0 10:10:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:10:29 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')]} 10:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:29 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')]} 10:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:29 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 0x10c732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7bd85e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c510d30>, '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 0x10c437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c505be8>, '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.L9PsZFii3s/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.QJeTRj7ECk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 10:10:29 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 10:10:29 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 10:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9PsZFii3s/Render', 10:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:29 INFO - 'HOME': '/Users/cltbld', 10:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:29 INFO - 'LOGNAME': 'cltbld', 10:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:29 INFO - 'MOZ_NO_REMOTE': '1', 10:10:29 INFO - 'NO_EM_RESTART': '1', 10:10:29 INFO - 'PAGER': '/bin/cat', 10:10:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:29 INFO - 'PWD': '/builds/slave/test', 10:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:29 INFO - 'SHELL': '/bin/bash', 10:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJeTRj7ECk/Listeners', 10:10:29 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 10:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:29 INFO - 'USER': 'cltbld', 10:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:29 INFO - 'XPC_FLAGS': '0x0', 10:10:29 INFO - 'XPC_SERVICE_NAME': '0', 10:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:10:32 INFO - Installing collected packages: mozsystemmonitor 10:10:32 INFO - Running setup.py install for mozsystemmonitor 10:10:33 INFO - Successfully installed mozsystemmonitor 10:10:33 INFO - Cleaning up... 10:10:33 INFO - Return code: 0 10:10:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7bd85e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c510d30>, '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 0x10c437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c505be8>, '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.L9PsZFii3s/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.QJeTRj7ECk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 10:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9PsZFii3s/Render', 10:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:33 INFO - 'HOME': '/Users/cltbld', 10:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:33 INFO - 'LOGNAME': 'cltbld', 10:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:33 INFO - 'MOZ_NO_REMOTE': '1', 10:10:33 INFO - 'NO_EM_RESTART': '1', 10:10:33 INFO - 'PAGER': '/bin/cat', 10:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:33 INFO - 'PWD': '/builds/slave/test', 10:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:33 INFO - 'SHELL': '/bin/bash', 10:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJeTRj7ECk/Listeners', 10:10:33 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 10:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:33 INFO - 'USER': 'cltbld', 10:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:33 INFO - 'XPC_FLAGS': '0x0', 10:10:33 INFO - 'XPC_SERVICE_NAME': '0', 10:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:33 INFO - Downloading/unpacking jsonschema==2.5.1 10:10:33 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 10:10:33 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 10:10:33 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 10:10:33 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 10:10:33 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 10:10:33 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 10:10:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:10:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:36 INFO - Downloading functools32-3.2.3-2.tar.gz 10:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:10:36 INFO - warning: no files found matching '*.txt' 10:10:36 INFO - no previously-included directories found matching 'build' 10:10:36 INFO - no previously-included directories found matching 'dist' 10:10:36 INFO - no previously-included directories found matching '.git*' 10:10:36 INFO - Installing collected packages: jsonschema, functools32 10:10:36 INFO - Running setup.py install for functools32 10:10:37 INFO - warning: no files found matching '*.txt' 10:10:37 INFO - no previously-included directories found matching 'build' 10:10:37 INFO - no previously-included directories found matching 'dist' 10:10:37 INFO - no previously-included directories found matching '.git*' 10:10:37 INFO - Successfully installed jsonschema functools32 10:10:37 INFO - Cleaning up... 10:10:37 INFO - Return code: 0 10:10:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7bd85e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c510d30>, '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 0x10c437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c505be8>, '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.L9PsZFii3s/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.QJeTRj7ECk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 10:10:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:10:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:10:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9PsZFii3s/Render', 10:10:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:37 INFO - 'HOME': '/Users/cltbld', 10:10:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:37 INFO - 'LOGNAME': 'cltbld', 10:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:37 INFO - 'MOZ_NO_REMOTE': '1', 10:10:37 INFO - 'NO_EM_RESTART': '1', 10:10:37 INFO - 'PAGER': '/bin/cat', 10:10:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:37 INFO - 'PWD': '/builds/slave/test', 10:10:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:37 INFO - 'SHELL': '/bin/bash', 10:10:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJeTRj7ECk/Listeners', 10:10:37 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 10:10:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:37 INFO - 'USER': 'cltbld', 10:10:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:37 INFO - 'XPC_FLAGS': '0x0', 10:10:37 INFO - 'XPC_SERVICE_NAME': '0', 10:10:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:10:37 INFO - Cleaning up... 10:10:37 INFO - Return code: 0 10:10:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7bd85e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c510d30>, '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 0x10c437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c505be8>, '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.L9PsZFii3s/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.QJeTRj7ECk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 10:10:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:10:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:10:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9PsZFii3s/Render', 10:10:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:37 INFO - 'HOME': '/Users/cltbld', 10:10:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:37 INFO - 'LOGNAME': 'cltbld', 10:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:37 INFO - 'MOZ_NO_REMOTE': '1', 10:10:37 INFO - 'NO_EM_RESTART': '1', 10:10:37 INFO - 'PAGER': '/bin/cat', 10:10:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:37 INFO - 'PWD': '/builds/slave/test', 10:10:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:37 INFO - 'SHELL': '/bin/bash', 10:10:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJeTRj7ECk/Listeners', 10:10:37 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 10:10:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:37 INFO - 'USER': 'cltbld', 10:10:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:37 INFO - 'XPC_FLAGS': '0x0', 10:10:37 INFO - 'XPC_SERVICE_NAME': '0', 10:10:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:38 INFO - Downloading/unpacking blobuploader==1.2.4 10:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:40 INFO - Downloading blobuploader-1.2.4.tar.gz 10:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:10:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:10:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:41 INFO - Downloading docopt-0.6.1.tar.gz 10:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:10:42 INFO - Installing collected packages: blobuploader, requests, docopt 10:10:42 INFO - Running setup.py install for blobuploader 10:10:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:10:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:10:42 INFO - Running setup.py install for requests 10:10:42 INFO - Running setup.py install for docopt 10:10:42 INFO - Successfully installed blobuploader requests docopt 10:10:42 INFO - Cleaning up... 10:10:42 INFO - Return code: 0 10:10:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:43 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 0x10c732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7bd85e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c510d30>, '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 0x10c437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c505be8>, '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.L9PsZFii3s/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.QJeTRj7ECk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 10:10:43 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 10:10:43 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 10:10:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9PsZFii3s/Render', 10:10:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:43 INFO - 'HOME': '/Users/cltbld', 10:10:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:43 INFO - 'LOGNAME': 'cltbld', 10:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:43 INFO - 'MOZ_NO_REMOTE': '1', 10:10:43 INFO - 'NO_EM_RESTART': '1', 10:10:43 INFO - 'PAGER': '/bin/cat', 10:10:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:43 INFO - 'PWD': '/builds/slave/test', 10:10:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:43 INFO - 'SHELL': '/bin/bash', 10:10:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJeTRj7ECk/Listeners', 10:10:43 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 10:10:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:43 INFO - 'USER': 'cltbld', 10:10:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:43 INFO - 'XPC_FLAGS': '0x0', 10:10:43 INFO - 'XPC_SERVICE_NAME': '0', 10:10:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-8QB5RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-8BEZ6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-abgKtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-s5k2ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-bInlhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-aj8y1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-R12XqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-NLqsoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-lA2kDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-IlPti4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-f8Qf_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-HeAJAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-xf02n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-tvK2f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-F1v2E1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-8Jbd_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-_CFhGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:10:45 INFO - Running setup.py install for manifestparser 10:10:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:10:45 INFO - Running setup.py install for mozcrash 10:10:45 INFO - Running setup.py install for mozdebug 10:10:45 INFO - Running setup.py install for mozdevice 10:10:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:10:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:10:45 INFO - Running setup.py install for mozfile 10:10:45 INFO - Running setup.py install for mozhttpd 10:10:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:10:45 INFO - Running setup.py install for mozinfo 10:10:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:10:46 INFO - Running setup.py install for mozInstall 10:10:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:10:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:10:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:10:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:10:46 INFO - Running setup.py install for mozleak 10:10:46 INFO - Running setup.py install for mozlog 10:10:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:10:46 INFO - Running setup.py install for moznetwork 10:10:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:10:46 INFO - Running setup.py install for mozprocess 10:10:46 INFO - Running setup.py install for mozprofile 10:10:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozrunner 10:10:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozscreenshot 10:10:47 INFO - Running setup.py install for moztest 10:10:47 INFO - Running setup.py install for mozversion 10:10:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:10:47 INFO - Cleaning up... 10:10:47 INFO - Return code: 0 10:10:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7bd85e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c510d30>, '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 0x10c437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c505be8>, '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.L9PsZFii3s/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.QJeTRj7ECk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 10:10:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:10:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9PsZFii3s/Render', 10:10:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:47 INFO - 'HOME': '/Users/cltbld', 10:10:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:47 INFO - 'LOGNAME': 'cltbld', 10:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:47 INFO - 'MOZ_NO_REMOTE': '1', 10:10:47 INFO - 'NO_EM_RESTART': '1', 10:10:47 INFO - 'PAGER': '/bin/cat', 10:10:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:47 INFO - 'PWD': '/builds/slave/test', 10:10:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:47 INFO - 'SHELL': '/bin/bash', 10:10:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJeTRj7ECk/Listeners', 10:10:47 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 10:10:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:47 INFO - 'USER': 'cltbld', 10:10:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:47 INFO - 'XPC_FLAGS': '0x0', 10:10:47 INFO - 'XPC_SERVICE_NAME': '0', 10:10:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-uY8soQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:48 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)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-tAGhce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-rCgFv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-tx1rN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:48 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)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-FNFVhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-g6SNMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-XerJGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Xfnbxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-VN6CT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-3QOOrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Fy_mmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:49 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-dgPLY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:49 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-n2UI46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:49 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-6t_FID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:49 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-u6bSM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:49 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-HsN7Tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:49 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-LtrbG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:10:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:52 INFO - Downloading blessings-1.6.tar.gz 10:10:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:10:52 INFO - Installing collected packages: blessings 10:10:52 INFO - Running setup.py install for blessings 10:10:52 INFO - Successfully installed blessings 10:10:52 INFO - Cleaning up... 10:10:52 INFO - Return code: 0 10:10:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:53 INFO - Reading from file tmpfile_stdout 10:10:53 INFO - Current package versions: 10:10:53 INFO - blessings == 1.6 10:10:53 INFO - blobuploader == 1.2.4 10:10:53 INFO - docopt == 0.6.1 10:10:53 INFO - functools32 == 3.2.3-2 10:10:53 INFO - jsonschema == 2.5.1 10:10:53 INFO - manifestparser == 1.1 10:10:53 INFO - mozInstall == 1.12 10:10:53 INFO - mozcrash == 1.0 10:10:53 INFO - mozdebug == 0.1 10:10:53 INFO - mozdevice == 0.49 10:10:53 INFO - mozfile == 1.2 10:10:53 INFO - mozhttpd == 0.7 10:10:53 INFO - mozinfo == 0.9 10:10:53 INFO - mozleak == 0.1 10:10:53 INFO - mozlog == 3.4 10:10:53 INFO - moznetwork == 0.27 10:10:53 INFO - mozprocess == 0.25 10:10:53 INFO - mozprofile == 0.28 10:10:53 INFO - mozrunner == 6.13 10:10:53 INFO - mozscreenshot == 0.1 10:10:53 INFO - mozsystemmonitor == 0.3 10:10:53 INFO - moztest == 0.8 10:10:53 INFO - mozversion == 1.4 10:10:53 INFO - psutil == 3.1.1 10:10:53 INFO - requests == 1.2.3 10:10:53 INFO - wsgiref == 0.1.2 10:10:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7bd85e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c510d30>, '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 0x10c437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c505be8>, '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.L9PsZFii3s/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.QJeTRj7ECk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 10:10:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:10:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9PsZFii3s/Render', 10:10:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:53 INFO - 'HOME': '/Users/cltbld', 10:10:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:53 INFO - 'LOGNAME': 'cltbld', 10:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:53 INFO - 'MOZ_NO_REMOTE': '1', 10:10:53 INFO - 'NO_EM_RESTART': '1', 10:10:53 INFO - 'PAGER': '/bin/cat', 10:10:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:53 INFO - 'PWD': '/builds/slave/test', 10:10:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:53 INFO - 'SHELL': '/bin/bash', 10:10:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJeTRj7ECk/Listeners', 10:10:53 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 10:10:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:53 INFO - 'USER': 'cltbld', 10:10:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:53 INFO - 'XPC_FLAGS': '0x0', 10:10:53 INFO - 'XPC_SERVICE_NAME': '0', 10:10:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:10:53 INFO - Cleaning up... 10:10:53 INFO - Return code: 0 10:10:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:53 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 0x10c732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe7bd85e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c510d30>, '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 0x10c437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c505be8>, '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.L9PsZFii3s/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.QJeTRj7ECk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 10:10:53 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 10:10:53 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 10:10:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9PsZFii3s/Render', 10:10:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:53 INFO - 'HOME': '/Users/cltbld', 10:10:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:53 INFO - 'LOGNAME': 'cltbld', 10:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:53 INFO - 'MOZ_NO_REMOTE': '1', 10:10:53 INFO - 'NO_EM_RESTART': '1', 10:10:53 INFO - 'PAGER': '/bin/cat', 10:10:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:53 INFO - 'PWD': '/builds/slave/test', 10:10:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:53 INFO - 'SHELL': '/bin/bash', 10:10:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJeTRj7ECk/Listeners', 10:10:53 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 10:10:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:53 INFO - 'USER': 'cltbld', 10:10:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:53 INFO - 'XPC_FLAGS': '0x0', 10:10:53 INFO - 'XPC_SERVICE_NAME': '0', 10:10:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:10:53 INFO - Cleaning up... 10:10:53 INFO - Return code: 0 10:10:53 INFO - Running post-action listener: _resource_record_post_action 10:10:53 INFO - Running post-action listener: _start_resource_monitoring 10:10:53 INFO - Starting resource monitoring. 10:10:53 INFO - [mozharness: 2017-04-21 17:10:53.614316Z] Finished create-virtualenv step (success) 10:10:53 INFO - [mozharness: 2017-04-21 17:10:53.615266Z] Running install step. 10:10:53 INFO - Running pre-action listener: _resource_record_pre_action 10:10:53 INFO - Running main action method: install 10:10:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:53 INFO - Reading from file tmpfile_stdout 10:10:53 INFO - Detecting whether we're running mozinstall >=1.0... 10:10:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:10:53 INFO - Reading from file tmpfile_stdout 10:10:53 INFO - Output received: 10:10:53 INFO - Usage: mozinstall [options] installer 10:10:53 INFO - Options: 10:10:53 INFO - -h, --help show this help message and exit 10:10:53 INFO - -d DEST, --destination=DEST 10:10:53 INFO - Directory to install application into. [default: 10:10:53 INFO - "/builds/slave/test"] 10:10:53 INFO - --app=APP Application being installed. [default: firefox] 10:10:53 INFO - mkdir: /builds/slave/test/build/application 10:10:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:11:08 INFO - Reading from file tmpfile_stdout 10:11:08 INFO - Output received: 10:11:08 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:11:08 INFO - Running post-action listener: _resource_record_post_action 10:11:08 INFO - [mozharness: 2017-04-21 17:11:08.855338Z] Finished install step (success) 10:11:08 INFO - [mozharness: 2017-04-21 17:11:08.855462Z] Running run-tests step. 10:11:08 INFO - Running pre-action listener: _resource_record_pre_action 10:11:08 INFO - Running main action method: run_tests 10:11:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:11:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:11:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:11:08 INFO - 2017-04-21 10:11:08.868 screenresolution[1623:7369] starting screenresolution argv=screenresolution get 10:11:08 INFO - 2017-04-21 10:11:08.870 screenresolution[1623:7369] Display 0: 1600x1200x32@60 10:11:08 INFO - 2017-04-21 10:11:08.875 screenresolution[1624:7371] starting screenresolution argv=screenresolution list 10:11:08 INFO - Available Modes on Display 0 10:11:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:11:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:11:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:11:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:11:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:11:09 INFO - Intel Iris: 10:11:09 INFO - Chipset Model: Intel Iris 10:11:09 INFO - Type: GPU 10:11:09 INFO - Bus: Built-In 10:11:09 INFO - VRAM (Dynamic, Max): 1536 MB 10:11:09 INFO - Vendor: Intel (0x8086) 10:11:09 INFO - Device ID: 0x0a2e 10:11:09 INFO - Revision ID: 0x0009 10:11:09 INFO - Displays: 10:11:09 INFO - Display: 10:11:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:11:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:11:09 INFO - Display Serial Number: 1600x1200 60 10:11:09 INFO - Main Display: Yes 10:11:09 INFO - Mirror: Off 10:11:09 INFO - Online: Yes 10:11:09 INFO - Rotation: Supported 10:11:09 INFO - Return code: 0 10:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:11:09 INFO - Python 2.7.3 10:11:09 INFO - Return code: 0 10:11:09 INFO - grabbing minidump binary from tooltool 10:11: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')]} 10:11:09 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 0x10c510d30>, '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 0x10c437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c505be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:11:09 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 10:11:09 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 10:11:09 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 10:11:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:11:09 INFO - Return code: 0 10:11:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:11:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:11:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:11:09 INFO - ENV: RUST_BACKTRACE is now 1 10:11:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:11:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:11:09 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/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--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 10:11:09 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/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0100 --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 10:11:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9PsZFii3s/Render', 10:11:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:11:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:11:09 INFO - 'HOME': '/Users/cltbld', 10:11:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:11:09 INFO - 'LOGNAME': 'cltbld', 10:11:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:11:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:09 INFO - 'MOZ_NO_REMOTE': '1', 10:11:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:11:09 INFO - 'NO_EM_RESTART': '1', 10:11:09 INFO - 'PAGER': '/bin/cat', 10:11:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:09 INFO - 'PWD': '/builds/slave/test', 10:11:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:11:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:11:09 INFO - 'RUST_BACKTRACE': '1', 10:11:09 INFO - 'SHELL': '/bin/bash', 10:11:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJeTRj7ECk/Listeners', 10:11:09 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 10:11:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:11:09 INFO - 'USER': 'cltbld', 10:11:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:11:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:09 INFO - 'XPC_FLAGS': '0x0', 10:11:09 INFO - 'XPC_SERVICE_NAME': '0', 10:11:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:11:09 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/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--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 10:11:09 INFO - mozversion application_buildid: 20170421084120 10:11:09 INFO - mozversion application_changeset: 188cc9e6d18d8dff122b0190e19c1e658b6d0f29 10:11:09 INFO - mozversion application_display_name: Firefox 10:11:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:11:09 INFO - mozversion application_name: Firefox 10:11:09 INFO - mozversion application_remotingname: firefox 10:11:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:11:09 INFO - mozversion application_vendor: Mozilla 10:11:09 INFO - mozversion application_version: 54.0 10:11:09 INFO - mozversion platform_buildid: 20170421084120 10:11:09 INFO - mozversion platform_changeset: 188cc9e6d18d8dff122b0190e19c1e658b6d0f29 10:11:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:11:09 INFO - mozversion platform_version: 54.0 10:11:09 INFO - using testdate: 1492794669 10:11:09 INFO - actual date: 1492794669 10:11:09 INFO - starting webserver on 'localhost:49242' 10:11:09 INFO - SUITE-START | Running 2 tests 10:11:09 INFO - TEST-START | dromaeo_css 10:11:09 INFO - operating with platform_type : mac_ 10:11:09 INFO - Initialising browser for dromaeo_css test... 10:11:09 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpXFUNjb/profile http://localhost:49242/getInfo.html) 10:11:11 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 10:11:11 INFO - PROCESS | 1634 | colorDepth:24 10:11:11 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 10:11:11 INFO - PROCESS | 1634 | __metrics 10:11:11 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:11:11 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:11:12 INFO - TEST-INFO | 1634: exit 0 10:11:12 INFO - Browser initialized. 10:11:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:11:12 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpXFUNjb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:24 INFO - PROCESS | 1637 | RSS: Main: 165203968 10:11:24 INFO - PROCESS | 1637 | 10:14:28 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 10:14:29 INFO - PROCESS | 1637 | RSS: Main: 289312768 10:14:29 INFO - PROCESS | 1637 | 10:17:32 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 10:17:33 INFO - PROCESS | 1637 | RSS: Main: 303996928 10:17:33 INFO - PROCESS | 1637 | 10:20:35 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 10:20:36 INFO - PROCESS | 1637 | RSS: Main: 295448576 10:20:36 INFO - PROCESS | 1637 | 10:23:38 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 10:23:39 INFO - PROCESS | 1637 | RSS: Main: 270082048 10:23:39 INFO - PROCESS | 1637 | 10:26:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 10:26:43 INFO - PROCESS | 1637 | RSS: Main: 277254144 10:26:43 INFO - PROCESS | 1637 | 10:29:46 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 10:29:46 INFO - PROCESS | 1637 | RSS: Main: 482201600 10:29:46 INFO - PROCESS | 1637 | 10:29:46 INFO - PROCESS | 1637 | __start_tp_report 10:29:46 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 10:29:46 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 10:29:46 INFO - PROCESS | 1637 | |i|pagename|runs| 10:29:46 INFO - PROCESS | 1637 | |0;dojo.html;3009.8495075246233;3553.0939610399346;3563.127033876702;3572.3391172633064;3611.1152767571934;5917.497012753915;6068.453839154476;6100.725467353968;6136.355682653324;6140.355262697414;6062.18160548327;6109.358517355669;6121.571489995691;6121.724522396492;6126.877462450749;5426.810061647853;5467.617266791326;5477.424870388591;5492.368377636583;5618.269624948772;5203.427622961472;5208.479152084799;5232.843014709546;5584.385717571064;5602.551795856342;5282.102042652758;5309.681419114865;5309.734513274321;5316.548093412064;5317.8404647860625;5504.80733174339;5558.110702287615;5580.720963951786;5593.692346920918;5599.992001439739;5407.864803379947;5516.889662206773;5531.7234138293325;5543.417941116165;5589.385167631598;5841.065429531254;6153.446189842891;6157.7229024694;6176.69116544171;6227.221597300338;6265.4361107500545;6291.150694656254;6300.905486417708;6330.620162790201;6338.366163383671;6504.804855854332;6506.707198176094;6510.869782604369;6519.152510173694;6521.9673901630185;6171;6210.192674952273;6225.564210505221;6231.345708700612;6238.344973777734;6351.110844481776;6416.807495775134;6678.799636010927;6683.866322673519;6701.932980670228;6293.685315734195;6337.6197428154455;6365.904511432333;6386.265579458329;6387.680615969183;6471.611703297817;6516.706748196248;6521.08704781331;6527.902081468782;6535.0850880876715;6245.875082498324;6439.9356006440275;6441.516886233551;6443;6465.838354041187;6281.057841323838;6344.206974128234;6393.200849893763;6396.712147953353;6397.168368112209;5227.137522308853;5238.319018527567;5244.816431424882;5258.605604579672;5279.894402111936;4513.390692256503;4669.066186762661;4675.322078298627;4691.46048204454;4714.976425117852;6132.846678833065;6135.69203737716;6144.787876364505;6210.844728881723;6229.221347331583;6534.901976470357;6553.705083271264;6568.704408301638;6568.86862262752;6580.407763301326;6265.185525881698;6278.277998030194;6280.528960327993;6285.931391663428;6292.465140463112;5495.203195536705;5591.720413979285;5649.717514124277;5761.827145185651;5779.017567013618;6666.500012499082;6749.493787965824;6788.694508747217;6789.321067893171;6809.319068093151;6476.417122459001;6539.084528166156;6542.640154791532;6543.869122617616;6549.7707580236365;6451.096846441408;6726.966365168143;6801.1158549388265;6805.9659701701175;6824.897626535507;6291.559590828598;6311.873762524632;6357.205349331333;6412.102305677302;6423.100765892686;6511.413972742476;6511.9348806511325;6521.706523206372;6524.282328943717;6533.575317604341;6169.383061693795;6202.937970620236;6211.378862113933;6236.781712640036;6305.369463053841;6340.809775706736;6343.55595108338;6347.809565713036;6355.046742988588;6357.014662727284;6084.969575152096;6101.512952543724;6106.195129949109;6140.815775526741;6289;6192.752289908533;6200.56596038273;6254.562180647311;6261.24865016201;6269.655168965751;6253.593516421418;6268.686565671607;6271.62370257786;6275.152854364603;6306.148669929501 10:29:46 INFO - PROCESS | 1637 | |1;ext.html;648.9545731798773;823.3577809308741;896.6054935828236;902.832975899459;910.6812615584543;40096;40598;40628.79685601572;40676.79661601695;40694.79652601733;42128;42417.78791106048;42499.57500424995;42539.14921701564;42605.7869710651;7863.292303692667;9491.857622135656;9667.12995830375;9670.903290967106;9698.90301096987;7906.802329941769;9848.212143028577;11844.466998985066;12199.024078073777;12199.390030498484;11837.822432663517;11925;11933.701657458547;11943.34311612861;11944.940275298655;11845.822312665317;11881;11905;11912.821307680391;11922.940385298105;11451.541938322458;11493.885061149365;11504.482298296596;11515.539378424854;11531.76936461266;39753.40369894454;39909.00227494307;39940.800295998626;39953;39966.200675986605;3986.80065996699;4022.275990321741;4037.596240375968;4038.6365227129404;4059.4925634295714;27653.861730691217;28297.009604663737;29641.258968525744;30204.54693179582;30509;3157.8263195524237;3227.2415982244156;3346.916327091818;3401.098708842159;3418.6068602110827;339307;342300;343033.2848335767;343841;344528;44197.116057678664;44628.77685611551;52796.47203527993;52825.735871320394;52974;57555.71222143946;58197.70901145467;58265.70867145637;58300;58373;15026.023308484913;15396.307166177548;15756.76364854528;15778.289976951064;15794.605134871721;13293.601191964257;13309.068365214342;13342.399592018382;13342.599722008355;13344.933275333562;11259.605913792979;12001.579944702069;12281.771822817826;13165.802512962313;13306.268155251553;5093.796248150106;5938.8218353449465;5986;6013.639181649115;6044.766050163142;980.5587485631495;986.1322036607739;1133.9773204535863;1176.5587904535798;1220.5544976083843;30270.243243919078;30342.089737307917;30495.542566861513;30638.38723225523;30901.69098308988;1008.0473952115327;1057.2546354819988;1074.8495210670512;1118.7874303882236;1124.1400328748514;15464.612037346444;15520.37918483248;15576.688466230838;15786.973846699928;15885.761713574306;522954;525187.3740631272;526566;526649;526702;59652.403475965555;59914;59926.70036649876;60135;60152.49618759566;1441.142520200479;1470.9117452952858;1474.351285434427;1480.592836969842;1494.9925250373678;22956.540869182856;25589.3602659935;28170.43659126847;28708;28939.56590651184;36101;41683;41726.79136604298;41754;41956;473968;477798;478296;479101;479686;25651.486970260117;25990.09034683777;26027.404108116847;30926;31248.50011998989;32075.679243208204;34922.825385873926;39637;40149.59850401458;42118.789406052776;28228.576571351856;28532.714672853836;28783.712162878102;28835.85582072076;29633.259168520097;27716.861415692794;28196;28299.575506367008;29383.412331753672;29531.852340738158;32645.334575530484;33484;33874.66125338715;33883.15292117717;33916.83041584875;27738.44523109486;27778;28089.43821123525;28530.144095677162;29181.854090729412;18977.52556186051;22963.540729185657;23321.183758568368;23325;23523.294301170994 10:29:46 INFO - PROCESS | 1637 | |2;jquery.html;432.83335915672455;438.05817492391367;444.96217821485175;445.1630933844372;459.05892919514986;19555.804441955577;21571.892140539294;22827.31518054459;23086.30741077768;23591.528169436602;18984;23525.41186470339;24030;24040.639390409113;24241.757582424172;6633.20401551812;6787.151606049244;6909.861802763941;7059.39995100417;7091.149062112528;6869.313068693115;6915.377616014558;6960.095187625601;6968.651567421609;6971.930280697205;6958.930410695904;7530.548167109991;7816.257455541714;7993.200679932019;7998.1601931797195;7796.571188584654;7858.724944626911;7882.132965373804;7944.602769861513;7947.165547617533;6012.609180403259;7695.153533111354;7700.268474494914;7704.30661240491;7708.267714567107;27476.45047099067;27708.861455692793;27920;28009.159725208276;28273.57589636157;3011.3224524481816;3044.101989912981;3088.2125058110264;3119.937601247985;3185.665505121975;16573.585660358465;17236.224369903386;17315.913420432942;17963.550911227194;17992.1003949802;2096.6121267565395;2127.1810353014203;2130.659094544865;2132.39226820357;2205.404540773998;164839.3516064836;174503.09938012323;175203;176413;182204;18744.906275468536;19660.90169549143;19830.107645156004;19852.20591176337;19951.501212469804;31004.68995310063;31430.528542071886;31515.054548363587;31592.894248701185;31612.683873160975;8416.368772342099;10545.191213490005;10797.190210734068;10823.621173258898;11019.944900275448;8973.641054357753;8999.865002024975;9015.233705135006;9191.31065170115;9201.539923003824;9019.368644194974;9201.493917834583;9268.212201962908;9288.34981551285;9304.395214311184;2858.714128587166;2985.1343110498146;3458.152752575635;3558.092686365012;3798.2213646203013;929.3726734454216;1068.609957365556;1101.6639924822846;1108.778244351133;1125.9303661521424;21748.13007479683;22139.778602213773;22216.555668886533;22235.777642223693;22297.219597314015;1092.137211602825;1092.7541303206874;1120.199057673751;1134.982975255372;1136.7840110379002;11040.834387484194;11403.201775875776;11543.942280288546;11650.242734222249;11652.825207621892;752761;754965;760917;762508;780362;130510.34744826215;163968;166345;169714;170358.29641703673;1189.1794661683412;1249.2754202562492;1286.8584455709865;1342.838859336886;1344.8318960129984;19432.611347772683;19585.314513991943;19919.302824401075;20655.96720164016;20672.276470323468;67326.31684207934;67454;68045;68047.97928030984;69308;96799;97002.54496182704;97437.02562974564;97473.51263243638;100027.99944000934;11556.075513958695;11614.187006909435;11630.94184529072;11659.125565582446;11975.161738678209;12249.326287054297;13016.8047479286;13404.530841420894;13433.932830335785;13559.45762169502;11228.831567526657;11248.212625116163;11549.249298795552;11719.531218751154;11733.296002239893;8658.177473140042;10727.946360268148;10740.892591074302;10758.46207689628;10783.299085559414;9467.715968520955;11498.885011149781;11644.35956022427;11825.467853946766;11972.461239244429;11122.277051991594;11606.535738570363;11667.941660291644;11698.122640801803;11985.400729963641;9352.67265645699;10320.638777642747;11342.20604557673;11367.658970230907;11697.649070527897 10:29:46 INFO - PROCESS | 1637 | |3;mootools.html;1257.4530079415456;1532.7164474572205;1565.193925128559;1608.7023900578386;1658.834116588341;10975.957284058011;11626.360550169737;11647.941760291207;11668.299902005885;11677.649670509876;11457.197996140274;11563.479643416045;11857.584984525543;11958.402079895992;11969.982551483112;2436.1595249638935;2504.6368276599883;2506.4235225898055;2508.5233805576972;2512.2337687005456;2442.2306973303444;2479.603263477835;2513.070164039299;2515.9874200629065;2520.8109391795597;2442.2917353967327;2469.6665950096776;2495.2264797912703;2496.2012156110054;2499.0128899084852;2418.286605451396;2436.098643501898;2460.175841093227;2464.3592665906813;2469.555480013606;2453.5092981403614;2475.232677869866;2475.913343033003;2486.8880900359345;2488.35302821266;11296.943515282454;11474;11500.482478288497;11505.252158609746;11525.36610486423;5872.823815285506;6065.090236464522;6067.878642427171;6072.05883088122;6076.301225359096;3608.4948107265004;3716.1267102230954;3738.140227747606;3797.791121488317;3810.599887011879;1272.28116114396;1744.9825501744947;1925.740025096608;1927.2002119120548;1941.1264930781206;14076.648083797885;14362.712745745132;14714.926425367805;16244.593885152966;16406.83593164065;4905.092557876804;5065.518775716301;5082.364704411949;5095.745212739348;5104.719240441737;13215.074944753967;13219.603411897466;13231.735365292832;13232.20606763578;13232.470701171846;5177.767000484987;5333.813316533902;5349.66353693157;5391.595630327741;6107.358727333566;5133.307003554472;5316.6544174628525;5543.1408131739645;5578.107502799533;5613;3967.3850553164307;3978.224246271949;4066.4510291110914;4068.6541643960595;4074.694397920168;1044.206403133624;1055.2244100586217;1070.4754670211696;1073.2326386633595;1073.4042606353394;957.2772556719632;972.99027009729;982.7641366072091;996.5067291690659;1003.2225025605214;6899.793006209822;7006.859862802818;7073.929260707327;7121.964390178119;7134.464915131386;933.6498812945146;993.344392700814;1008.3748076192808;1009.222898368267;1086.6794295682791;4334.089841133335;4342.82628694855;4459.1304695584695;4463.754493502888;4677.041206552649;13498.86501134976;13902.721945561234;13936.163830170222;14042.227677477633;14064.226467544384;13652.453901843815;13760.243186624832;14016;14024.579262622137;14033.929830350782;10249.795004099877;10508.211884108723;10509.842352364567;10513.579456821795;10538.683839484827;6793.932060679527;6844.452443804584;6860.965695171492;6900.309969003059;6982.162140543167;10952.780944381228;11306.982371586597;12667.619971400873;12698.555550555686;12724.300163491096;12043.397830108635;12267.815982760087;12800.35998200105;12962.416691248727;13028.54400095992;9313.674021409219;9317.813643727222;9491.620335186515;9568.808623827344;9579.856302155335;9616.75958101053;9778.65774697882;10288.742781430525;10299.794004120025;10507.054365107177;8560;8643;8764.956175219084;8865.468071915706;8929.24101451358;8496.490210587384;8571;8591.6992905248;8631.482111073105;8662.82674346497;8067.757967260992;8116.066652334821;8216.137305582828;8223.383246256675;8227.629756660845;5208.687478751287;5909.734061967136;5956.778860333535;6061.787837425669;6101.908471372844;6017.638941663514;6033.758649653964;6108.5723999319625;6222.875542489215;6353.777617783356 10:29:46 INFO - PROCESS | 1637 | |4;prototype.html;395.1819733152375;396.32031066720566;400.7776282338867;403.5077205808912;407.2974119643615;4550.269838097149;5253.579713622906;5289.709066001373;5342.866428339294;5365.839024829252;4482.372467854495;4583.487449141783;4632.675712700104;5041.395032596093;5187.584993200544;3782.3759079751876;4036.7981600919984;4078.1843631273714;4121.319982202933;4135.917281654365;3431.3308904763458;3640.3447379471686;3832.310184166849;4042.7147223942716;4103.8563650272245;3696.445533170019;3826.5982071882468;3922.6469617734397;4135.028268356934;4155.542890282067;3579.1410061585293;3750.7562008469363;3914.902127446808;4007.5391329997133;4023.0948036691802;3631.8184090795353;3636.690881275095;3663.3222853772136;3668.578113516953;3754.9436758448373;4875.804967801284;5050.191969284933;5081.339425874649;5091.745412729349;5185.766640501187;4362.672799540015;4484.148011877733;4701.990725935404;4748.358971538867;4799.2801079837955;4731.6578293744815;4817.56641902227;5014.523620256106;5019.895622962942;5576.247206627094;3362.512435696835;3418.3505134024704;3441.7609660522444;4057.1277175407135;4105.5894410559;4465.218586747306;5135.922961155586;5634.32388113429;5710.857228569319;5819.67991760453;4849.878753031202;4854.563089321978;4901.828436004723;4906.484819093944;4920.114379411741;4390.407295015196;4829.1307564638;5003.524665156804;5024.371953505812;5025.597952163891;4261.552536983572;4875.317455556225;4935.593355893553;5207.52642494812;5207.973960130175;4987.376577927759;5015.297858299841;5443.537299329522;5455.918161227585;5569.359523654751;1492.2016721054183;1594.6970075685583;1710.7006273902266;1711.9743203851951;1729.5503169176104;1218.9009047460572;1264.8616245379233;1280.7630588341187;1385.840628327735;1402.7194561087824;4411.735295882258;5025.4974502550185;5184.677907133732;5247.425772268304;5267.9736601316745;4925.802967881316;5187.870303242374;5591.210812540029;5787.913181302284;5799.507041901401;4531.954680453153;4798.736069516141;4842.128416884994;5058.231617445027;5319.627626066138;2354.893200195905;2465.878025498394;2509.86195759235;2734.2754170144926;2865.323785585456;5068.41713202979;5813.82558523245;5823.621464604787;5841.853953651193;5875.942330380487;4911.852644420673;5169;5231.581473482112;5366.946330536644;5483.862903427446;4936.876578085505;5153.587712982952;5336.839894803162;5931.644101353846;5978.671173085522;4546.886012926854;4782.713037217778;5085.4914508548845;5578.525825304894;5604.8038318658655;4737.981334013204;5035.104239343129;5239.947600524099;5479.726013699379;5551.306086739158;5134.255532947627;5559.555235581063;5571.220029195997;5808.883822323445;5933.110033495011;3894.7857867817543;4063.3904914261916;4176.686748493815;4501.639868810553;4506.459224893034;5037.899242015213;5638.716319890451;5671.262735844314;5698.182217913924;5826.912596310974;4684.789184486638;4845.491223421631;5014.874628134326;5126.56424203932;5480.72596370172;4744.169770290255;5154.974225128851;5465.196485159967;5535.982889325408;5565.582581306499;5039.874003149951;5357.866053348697;5391.487808658171;5393.730313484389;5402.75687594067;4989.353513340661;5003.574696150868;5435.755391007335;5581.6371935824045;5639.520640745583;5052.520010598987;5141.560363098189;5405.216313598421;5454.454554544673;5470.350202328148 10:29:46 INFO - PROCESS | 1637 | |5;yui.html;761.3870833978649;803.1326167738843;878.3061381508606;880.8872216916002;909.1226965977833;15530.689386212269;16882;17053.317867285325;17138;17189.656206875872;15385;15533.844661553381;15752.527424177264;15936.681266374666;16254.918725406385;995.21378111292;996.1234113979724;996.9551370188323;1000.1598657128011;1001.234055947201;990.8315586350337;1000.8999100090006;1032.5972870580479;1034.3690348887174;1035.4098164046497;1074.087026027874;1075.7794652096302;1076.101455284838;1078.4607696151925;1078.7195329214383;1071.769569542552;1073.2809017957948;1074.4466599701161;1074.6346242277584;1074.8280275155937;797.948133371329;798.9800254993613;799.0052384780927;799.0092285565914;799.9680012799481;17383.73924391135;17418.564535886577;17467.213975371138;18109.366172184044;18323.816761832346;14630.26848657563;14681.045732027384;14766.557003289918;14806;14812.111273323635;11918.821217681741;11940;12064.396780160956;12122.39388030595;12304.753904921941;3336.6830151135605;3768.3405404054456;3868.9226215475815;3909.2181563687377;4027.8993025174314;116415.4179229107;116462.41768791102;119297;120219;122664;8693.43492672987;8781.736547903573;8809.911900880908;8812.91187088121;9026.097390260922;19764.60470790576;23812.64281035786;24126.276211713677;24163.39591510191;24173.879130604586;6809.353111454404;7784.104827944859;7827.1390147083775;8066.072401673765;8182.7545173644885;4398.097691469323;4508.143452743968;4565.497795242521;4610.746408947473;4746.952530474651;3652.19651676636;3680.1351682354625;3705.4627079073384;3746.981265093657;3757.981210093932;485.5435890263141;560.8054843184074;563.9661620302795;578.3580225949192;580.686429328158;660.3693472733528;723.2333726250191;742.3479348196669;747.1407880936857;770.3759954436924;10217.438040907673;10241.334313269614;10269.7432564185;10518.789624207473;10588.894111058946;727.2654618835015;730.9780706578811;736.3851184261202;743.2827321634649;743.498133769782;4905.3132561441425;5207.843764687065;5210.400803907523;5211.739413029333;5219.608529360313;104183;110013.44993275142;114113;114890;118010.81989179998;89153;94922;95316;97185;97896;83942.74085888716;84453;84650.15349846422;85398.14601853902;87052.1294787044;9468.289878259297;9489.85765213536;9920.355176913477;10054.798904022025;10101.49492525356;48401.54795356145;49878;51721.7413912928;52173.7391313041;52255.21617175669;60631.69684151551;67290.32709673037;71380.64309678625;72390.63804681154;74623.62688186525;13350.866491334962;13548.59354219375;13848;14123.223222722438;14435.566932992027;15572.454964076203;15710;15992.200389980222;16703.91648041752;16833.831661683227;13000.674983125498;13152.342382880626;13497.730045399234;14118.364673589507;14161.575152745434;14325.78511322352;14692.853071469148;14842.332095055532;14848.034877732913;14982.026168299026;13441.596752097452;13607;13926.58220253394;14605.269736512919;14957.326920288395;8044.178188016533;9842.21262299;10161.339512931636;10367.429791361548;10663.840042399215;9982.650607228712;10363.952675743856;11885.108616853944;12064.095192860746;12124.757504849676 10:29:46 INFO - PROCESS | 1637 | __end_tp_report 10:29:46 INFO - PROCESS | 1637 | __start_cc_report 10:29:46 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1585 10:29:46 INFO - PROCESS | 1637 | __end_cc_report 10:29:46 INFO - PROCESS | 1637 | __startTimestamp1492795786924__endTimestamp 10:29:46 INFO - PROCESS | 1637 | 10:29:46 INFO - PROCESS | 1637 | ------- Summary: start ------- 10:29:46 INFO - PROCESS | 1637 | Number of tests: 6 10:29:46 INFO - PROCESS | 1637 | 10:29:46 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:6028.50 Median:6254.56 stddev:668.18 (10.7%) stddev-sans-first:626.86 10:29:46 INFO - PROCESS | 1637 | Values: 3009.8 3553.1 3563.1 3572.3 3611.1 5917.5 6068.5 6100.7 6136.4 6140.4 6062.2 6109.4 6121.6 6121.7 6126.9 5426.8 5467.6 5477.4 5492.4 5618.3 5203.4 5208.5 5232.8 5584.4 5602.6 5282.1 5309.7 5309.7 5316.5 5317.8 5504.8 5558.1 5580.7 5593.7 5600.0 5407.9 5516.9 5531.7 5543.4 5589.4 5841.1 6153.4 6157.7 6176.7 6227.2 6265.4 6291.2 6300.9 6330.6 6338.4 6504.8 6506.7 6510.9 6519.2 6522.0 6171.0 6210.2 6225.6 6231.3 6238.3 6351.1 6416.8 6678.8 6683.9 6701.9 6293.7 6337.6 6365.9 6386.3 6387.7 6471.6 6516.7 6521.1 6527.9 6535.1 6245.9 6439.9 6441.5 6443.0 6465.8 6281.1 6344.2 6393.2 6396.7 6397.2 5227.1 5238.3 5244.8 5258.6 5279.9 4513.4 4669.1 4675.3 4691.5 4715.0 6132.8 6135.7 6144.8 6210.8 6229.2 6534.9 6553.7 6568.7 6568.9 6580.4 6265.2 6278.3 6280.5 6285.9 6292.5 5495.2 5591.7 5649.7 5761.8 5779.0 6666.5 6749.5 6788.7 6789.3 6809.3 6476.4 6539.1 6542.6 6543.9 6549.8 6451.1 6727.0 6801.1 6806.0 6824.9 6291.6 6311.9 6357.2 6412.1 6423.1 6511.4 6511.9 6521.7 6524.3 6533.6 6169.4 6202.9 6211.4 6236.8 6305.4 6340.8 6343.6 6347.8 6355.0 6357.0 6085.0 6101.5 6106.2 6140.8 6289.0 6192.8 6200.6 6254.6 6261.2 6269.7 6253.6 6268.7 6271.6 6275.2 6306.1 10:29:46 INFO - PROCESS | 1637 | 10:29:46 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:58364.73 Median:17203.16 stddev:121185.36 (704.4%) stddev-sans-first:121447.84 10:29:46 INFO - PROCESS | 1637 | Values: 649.0 823.4 896.6 902.8 910.7 40096.0 40598.0 40628.8 40676.8 40694.8 42128.0 42417.8 42499.6 42539.1 42605.8 7863.3 9491.9 9667.1 9670.9 9698.9 7906.8 9848.2 11844.5 12199.0 12199.4 11837.8 11925.0 11933.7 11943.3 11944.9 11845.8 11881.0 11905.0 11912.8 11922.9 11451.5 11493.9 11504.5 11515.5 11531.8 39753.4 39909.0 39940.8 39953.0 39966.2 3986.8 4022.3 4037.6 4038.6 4059.5 27653.9 28297.0 29641.3 30204.5 30509.0 3157.8 3227.2 3346.9 3401.1 3418.6 339307.0 342300.0 343033.3 343841.0 344528.0 44197.1 44628.8 52796.5 52825.7 52974.0 57555.7 58197.7 58265.7 58300.0 58373.0 15026.0 15396.3 15756.8 15778.3 15794.6 13293.6 13309.1 13342.4 13342.6 13344.9 11259.6 12001.6 12281.8 13165.8 13306.3 5093.8 5938.8 5986.0 6013.6 6044.8 980.6 986.1 1134.0 1176.6 1220.6 30270.2 30342.1 30495.5 30638.4 30901.7 1008.0 1057.3 1074.8 1118.8 1124.1 15464.6 15520.4 15576.7 15787.0 15885.8 522954.0 525187.4 526566.0 526649.0 526702.0 59652.4 59914.0 59926.7 60135.0 60152.5 1441.1 1470.9 1474.4 1480.6 1495.0 22956.5 25589.4 28170.4 28708.0 28939.6 36101.0 41683.0 41726.8 41754.0 41956.0 473968.0 477798.0 478296.0 479101.0 479686.0 25651.5 25990.1 26027.4 30926.0 31248.5 32075.7 34922.8 39637.0 40149.6 42118.8 28228.6 28532.7 28783.7 28835.9 29633.3 27716.9 28196.0 28299.6 29383.4 29531.9 32645.3 33484.0 33874.7 33883.2 33916.8 27738.4 27778.0 28089.4 28530.1 29181.9 18977.5 22963.5 23321.2 23325.0 23523.3 10:29:46 INFO - PROCESS | 1637 | 10:29:46 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:44893.03 Median:22178.17 stddev:127858.13 (576.5%) stddev-sans-first:128173.22 10:29:46 INFO - PROCESS | 1637 | Values: 432.8 438.1 445.0 445.2 459.1 19555.8 21571.9 22827.3 23086.3 23591.5 18984.0 23525.4 24030.0 24040.6 24241.8 6633.2 6787.2 6909.9 7059.4 7091.1 6869.3 6915.4 6960.1 6968.7 6971.9 6958.9 7530.5 7816.3 7993.2 7998.2 7796.6 7858.7 7882.1 7944.6 7947.2 6012.6 7695.2 7700.3 7704.3 7708.3 27476.5 27708.9 27920.0 28009.2 28273.6 3011.3 3044.1 3088.2 3119.9 3185.7 16573.6 17236.2 17315.9 17963.6 17992.1 2096.6 2127.2 2130.7 2132.4 2205.4 164839.4 174503.1 175203.0 176413.0 182204.0 18744.9 19660.9 19830.1 19852.2 19951.5 31004.7 31430.5 31515.1 31592.9 31612.7 8416.4 10545.2 10797.2 10823.6 11019.9 8973.6 8999.9 9015.2 9191.3 9201.5 9019.4 9201.5 9268.2 9288.3 9304.4 2858.7 2985.1 3458.2 3558.1 3798.2 929.4 1068.6 1101.7 1108.8 1125.9 21748.1 22139.8 22216.6 22235.8 22297.2 1092.1 1092.8 1120.2 1135.0 1136.8 11040.8 11403.2 11543.9 11650.2 11652.8 752761.0 754965.0 760917.0 762508.0 780362.0 130510.3 163968.0 166345.0 169714.0 170358.3 1189.2 1249.3 1286.9 1342.8 1344.8 19432.6 19585.3 19919.3 20656.0 20672.3 67326.3 67454.0 68045.0 68048.0 69308.0 96799.0 97002.5 97437.0 97473.5 100028.0 11556.1 11614.2 11630.9 11659.1 11975.2 12249.3 13016.8 13404.5 13433.9 13559.5 11228.8 11248.2 11549.2 11719.5 11733.3 8658.2 10727.9 10740.9 10758.5 10783.3 9467.7 11498.9 11644.4 11825.5 11972.5 11122.3 11606.5 11667.9 11698.1 11985.4 9352.7 10320.6 11342.2 11367.7 11697.6 10:29:46 INFO - PROCESS | 1637 | 10:29:46 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6944.39 Median:2505.53 stddev:4300.76 (171.7%) stddev-sans-first:4291.59 10:29:46 INFO - PROCESS | 1637 | Values: 1257.5 1532.7 1565.2 1608.7 1658.8 10976.0 11626.4 11647.9 11668.3 11677.6 11457.2 11563.5 11857.6 11958.4 11970.0 2436.2 2504.6 2506.4 2508.5 2512.2 2442.2 2479.6 2513.1 2516.0 2520.8 2442.3 2469.7 2495.2 2496.2 2499.0 2418.3 2436.1 2460.2 2464.4 2469.6 2453.5 2475.2 2475.9 2486.9 2488.4 11296.9 11474.0 11500.5 11505.3 11525.4 5872.8 6065.1 6067.9 6072.1 6076.3 3608.5 3716.1 3738.1 3797.8 3810.6 1272.3 1745.0 1925.7 1927.2 1941.1 14076.6 14362.7 14714.9 16244.6 16406.8 4905.1 5065.5 5082.4 5095.7 5104.7 13215.1 13219.6 13231.7 13232.2 13232.5 5177.8 5333.8 5349.7 5391.6 6107.4 5133.3 5316.7 5543.1 5578.1 5613.0 3967.4 3978.2 4066.5 4068.7 4074.7 1044.2 1055.2 1070.5 1073.2 1073.4 957.3 973.0 982.8 996.5 1003.2 6899.8 7006.9 7073.9 7122.0 7134.5 933.6 993.3 1008.4 1009.2 1086.7 4334.1 4342.8 4459.1 4463.8 4677.0 13498.9 13902.7 13936.2 14042.2 14064.2 13652.5 13760.2 14016.0 14024.6 14033.9 10249.8 10508.2 10509.8 10513.6 10538.7 6793.9 6844.5 6861.0 6900.3 6982.2 10952.8 11307.0 12667.6 12698.6 12724.3 12043.4 12267.8 12800.4 12962.4 13028.5 9313.7 9317.8 9491.6 9568.8 9579.9 9616.8 9778.7 10288.7 10299.8 10507.1 8560.0 8643.0 8765.0 8865.5 8929.2 8496.5 8571.0 8591.7 8631.5 8662.8 8067.8 8116.1 8216.1 8223.4 8227.6 5208.7 5909.7 5956.8 6061.8 6101.9 6017.6 6033.8 6108.6 6222.9 6353.8 10:29:46 INFO - PROCESS | 1637 | 10:29:46 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4518.52 Median:4962.13 stddev:1266.30 (25.5%) stddev-sans-first:1231.45 10:29:46 INFO - PROCESS | 1637 | Values: 395.2 396.3 400.8 403.5 407.3 4550.3 5253.6 5289.7 5342.9 5365.8 4482.4 4583.5 4632.7 5041.4 5187.6 3782.4 4036.8 4078.2 4121.3 4135.9 3431.3 3640.3 3832.3 4042.7 4103.9 3696.4 3826.6 3922.6 4135.0 4155.5 3579.1 3750.8 3914.9 4007.5 4023.1 3631.8 3636.7 3663.3 3668.6 3754.9 4875.8 5050.2 5081.3 5091.7 5185.8 4362.7 4484.1 4702.0 4748.4 4799.3 4731.7 4817.6 5014.5 5019.9 5576.2 3362.5 3418.4 3441.8 4057.1 4105.6 4465.2 5135.9 5634.3 5710.9 5819.7 4849.9 4854.6 4901.8 4906.5 4920.1 4390.4 4829.1 5003.5 5024.4 5025.6 4261.6 4875.3 4935.6 5207.5 5208.0 4987.4 5015.3 5443.5 5455.9 5569.4 1492.2 1594.7 1710.7 1712.0 1729.6 1218.9 1264.9 1280.8 1385.8 1402.7 4411.7 5025.5 5184.7 5247.4 5268.0 4925.8 5187.9 5591.2 5787.9 5799.5 4532.0 4798.7 4842.1 5058.2 5319.6 2354.9 2465.9 2509.9 2734.3 2865.3 5068.4 5813.8 5823.6 5841.9 5875.9 4911.9 5169.0 5231.6 5366.9 5483.9 4936.9 5153.6 5336.8 5931.6 5978.7 4546.9 4782.7 5085.5 5578.5 5604.8 4738.0 5035.1 5239.9 5479.7 5551.3 5134.3 5559.6 5571.2 5808.9 5933.1 3894.8 4063.4 4176.7 4501.6 4506.5 5037.9 5638.7 5671.3 5698.2 5826.9 4684.8 4845.5 5014.9 5126.6 5480.7 4744.2 5155.0 5465.2 5536.0 5565.6 5039.9 5357.9 5391.5 5393.7 5402.8 4989.4 5003.6 5435.8 5581.6 5639.5 5052.5 5141.6 5405.2 5454.5 5470.4 10:29:46 INFO - PROCESS | 1637 | 10:29:46 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:21861.49 Median:21788.62 stddev:32022.34 (147.0%) stddev-sans-first:32072.98 10:29:46 INFO - PROCESS | 1637 | Values: 761.4 803.1 878.3 880.9 909.1 15530.7 16882.0 17053.3 17138.0 17189.7 15385.0 15533.8 15752.5 15936.7 16254.9 995.2 996.1 997.0 1000.2 1001.2 990.8 1000.9 1032.6 1034.4 1035.4 1074.1 1075.8 1076.1 1078.5 1078.7 1071.8 1073.3 1074.4 1074.6 1074.8 797.9 799.0 799.0 799.0 800.0 17383.7 17418.6 17467.2 18109.4 18323.8 14630.3 14681.0 14766.6 14806.0 14812.1 11918.8 11940.0 12064.4 12122.4 12304.8 3336.7 3768.3 3868.9 3909.2 4027.9 116415.4 116462.4 119297.0 120219.0 122664.0 8693.4 8781.7 8809.9 8812.9 9026.1 19764.6 23812.6 24126.3 24163.4 24173.9 6809.4 7784.1 7827.1 8066.1 8182.8 4398.1 4508.1 4565.5 4610.7 4747.0 3652.2 3680.1 3705.5 3747.0 3758.0 485.5 560.8 564.0 578.4 580.7 660.4 723.2 742.3 747.1 770.4 10217.4 10241.3 10269.7 10518.8 10588.9 727.3 731.0 736.4 743.3 743.5 4905.3 5207.8 5210.4 5211.7 5219.6 104183.0 110013.4 114113.0 114890.0 118010.8 89153.0 94922.0 95316.0 97185.0 97896.0 83942.7 84453.0 84650.2 85398.1 87052.1 9468.3 9489.9 9920.4 10054.8 10101.5 48401.5 49878.0 51721.7 52173.7 52255.2 60631.7 67290.3 71380.6 72390.6 74623.6 13350.9 13548.6 13848.0 14123.2 14435.6 15572.5 15710.0 15992.2 16703.9 16833.8 13000.7 13152.3 13497.7 14118.4 14161.6 14325.8 14692.9 14842.3 14848.0 14982.0 13441.6 13607.0 13926.6 14605.3 14957.3 8044.2 9842.2 10161.3 10367.4 10663.8 9982.7 10364.0 11885.1 12064.1 12124.8 10:29:46 INFO - PROCESS | 1637 | -------- Summary: end -------- 10:29:46 INFO - PROCESS | 1637 | 10:29:47 INFO - TEST-INFO | 1637: exit 0 10:29:47 INFO - TEST-OK | dromaeo_css | took 1118074ms 10:29:47 INFO - TEST-START | kraken 10:29:47 INFO - operating with platform_type : mac_ 10:29:47 INFO - Initialising browser for kraken test... 10:29:47 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmptq0W2k/profile http://localhost:49242/getInfo.html) 10:29:49 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 10:29:49 INFO - PROCESS | 1646 | colorDepth:24 10:29:49 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 10:29:49 INFO - PROCESS | 1646 | __metrics 10:29:49 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:29:49 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:29:50 INFO - TEST-INFO | 1646: exit 0 10:29:50 INFO - Browser initialized. 10:29:50 INFO - Running cycle 1/1 for kraken test... 10:29:50 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmptq0W2k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:02 INFO - PROCESS | 1648 | RSS: Main: 165294080 10:30:02 INFO - PROCESS | 1648 | 10:30:05 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 10:30:06 INFO - PROCESS | 1648 | RSS: Main: 216133632 10:30:06 INFO - PROCESS | 1648 | 10:30:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 10:30:09 INFO - PROCESS | 1648 | RSS: Main: 231796736 10:30:09 INFO - PROCESS | 1648 | 10:30:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 10:30:13 INFO - PROCESS | 1648 | RSS: Main: 329465856 10:30:13 INFO - PROCESS | 1648 | 10:30:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 10:30:15 INFO - PROCESS | 1648 | RSS: Main: 230690816 10:30:15 INFO - PROCESS | 1648 | 10:30:17 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:30:18 INFO - PROCESS | 1648 | RSS: Main: 232292352 10:30:18 INFO - PROCESS | 1648 | 10:30:21 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 10:30:22 INFO - PROCESS | 1648 | RSS: Main: 272162816 10:30:22 INFO - PROCESS | 1648 | 10:30:24 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 10:30:25 INFO - PROCESS | 1648 | RSS: Main: 273453056 10:30:25 INFO - PROCESS | 1648 | 10:30:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 10:30:29 INFO - PROCESS | 1648 | RSS: Main: 271867904 10:30:29 INFO - PROCESS | 1648 | 10:30:30 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:30:31 INFO - PROCESS | 1648 | RSS: Main: 248938496 10:30:31 INFO - PROCESS | 1648 | 10:30:33 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:30:33 INFO - PROCESS | 1648 | RSS: Main: 252354560 10:30:33 INFO - PROCESS | 1648 | 10:30:35 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:30:36 INFO - PROCESS | 1648 | RSS: Main: 255221760 10:30:36 INFO - PROCESS | 1648 | 10:30:39 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:30:40 INFO - PROCESS | 1648 | RSS: Main: 261783552 10:30:40 INFO - PROCESS | 1648 | 10:30:42 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:30:43 INFO - PROCESS | 1648 | RSS: Main: 263155712 10:30:43 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 10:30:45 INFO - PROCESS | 1648 | RSS: Main: 307048448 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | __start_tp_report 10:30:45 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 10:30:45 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 10:30:45 INFO - PROCESS | 1648 | |i|pagename|runs| 10:30:45 INFO - PROCESS | 1648 | |0;ai-astar;108;118;119;119;118;119;119;119;114;118 10:30:45 INFO - PROCESS | 1648 | |1;audio-beat-detection;142;109;108;144;111;109;108;108;126;108 10:30:45 INFO - PROCESS | 1648 | |2;audio-dft;187;184;181;199;261;202;185;186;183;185 10:30:45 INFO - PROCESS | 1648 | |3;audio-fft;82;60;68;113;92;83;64;59;75;69 10:30:45 INFO - PROCESS | 1648 | |4;audio-oscillator;88;70;85;67;68;68;81;67;68;83 10:30:45 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;87;87;86;87;88;88;89;88;87;87 10:30:45 INFO - PROCESS | 1648 | |6;imaging-darkroom;94;95;95;94;94;95;96;95;93;95 10:30:45 INFO - PROCESS | 1648 | |7;imaging-desaturate;83;83;98;132;84;85;83;83;82;83 10:30:45 INFO - PROCESS | 1648 | |8;json-parse-financial;63;61;66;61;63;62;61;63;63;64 10:30:45 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;53;64;56;58;63;58;57;57;57;62 10:30:45 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;84;84;81;82;82;83;83;86;83;108 10:30:45 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;137;133;135;136;137;138;125;147;158;136 10:30:45 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;162;162;161;163;165;162;160;160;162;160 10:30:45 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;64;64;64;63;63;63;62;65;76;72 10:30:45 INFO - PROCESS | 1648 | __end_tp_report 10:30:45 INFO - PROCESS | 1648 | __start_cc_report 10:30:45 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2049 10:30:45 INFO - PROCESS | 1648 | __end_cc_report 10:30:45 INFO - PROCESS | 1648 | __startTimestamp1492795845581__endTimestamp 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | ------- Summary: start ------- 10:30:45 INFO - PROCESS | 1648 | Number of tests: 14 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:117.10 Median:119.00 stddev:3.54 (3.0%) stddev-sans-first:1.62 10:30:45 INFO - PROCESS | 1648 | Values: 108.0 118.0 119.0 119.0 118.0 119.0 119.0 119.0 114.0 118.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:117.30 Median:110.00 stddev:14.61 (13.3%) stddev-sans-first:12.47 10:30:45 INFO - PROCESS | 1648 | Values: 142.0 109.0 108.0 144.0 111.0 109.0 108.0 108.0 126.0 108.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:195.30 Median:186.50 stddev:24.10 (12.9%) stddev-sans-first:25.37 10:30:45 INFO - PROCESS | 1648 | Values: 187.0 184.0 181.0 199.0 261.0 202.0 185.0 186.0 183.0 185.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:76.50 Median:72.00 stddev:16.70 (23.2%) stddev-sans-first:17.60 10:30:45 INFO - PROCESS | 1648 | Values: 82.0 60.0 68.0 113.0 92.0 83.0 64.0 59.0 75.0 69.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:74.50 Median:75.50 stddev:8.61 (11.4%) stddev-sans-first:7.62 10:30:45 INFO - PROCESS | 1648 | Values: 88.0 70.0 85.0 67.0 68.0 68.0 81.0 67.0 68.0 83.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:87.50 stddev:0.84 (1.0%) stddev-sans-first:0.88 10:30:45 INFO - PROCESS | 1648 | Values: 87.0 87.0 86.0 87.0 88.0 88.0 89.0 88.0 87.0 87.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 10:30:45 INFO - PROCESS | 1648 | Values: 94.0 95.0 95.0 94.0 94.0 95.0 96.0 95.0 93.0 95.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:89.60 Median:83.00 stddev:15.62 (18.8%) stddev-sans-first:16.39 10:30:45 INFO - PROCESS | 1648 | Values: 83.0 83.0 98.0 132.0 84.0 85.0 83.0 83.0 82.0 83.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:1.57 (2.5%) stddev-sans-first:1.66 10:30:45 INFO - PROCESS | 1648 | Values: 63.0 61.0 66.0 61.0 63.0 62.0 61.0 63.0 63.0 64.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.00 stddev:3.44 (5.9%) stddev-sans-first:3.02 10:30:45 INFO - PROCESS | 1648 | Values: 53.0 64.0 56.0 58.0 63.0 58.0 57.0 57.0 57.0 62.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:83.00 stddev:7.99 (9.6%) stddev-sans-first:8.45 10:30:45 INFO - PROCESS | 1648 | Values: 84.0 84.0 81.0 82.0 82.0 83.0 83.0 86.0 83.0 108.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:137.00 stddev:8.78 (6.4%) stddev-sans-first:9.30 10:30:45 INFO - PROCESS | 1648 | Values: 137.0 133.0 135.0 136.0 137.0 138.0 125.0 147.0 158.0 136.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:1.57 (1.0%) stddev-sans-first:1.66 10:30:45 INFO - PROCESS | 1648 | Values: 162.0 162.0 161.0 163.0 165.0 162.0 160.0 160.0 162.0 160.0 10:30:45 INFO - PROCESS | 1648 | 10:30:45 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:64.00 stddev:4.60 (7.2%) stddev-sans-first:4.84 10:30:45 INFO - PROCESS | 1648 | Values: 64.0 64.0 64.0 63.0 63.0 63.0 62.0 65.0 76.0 72.0 10:30:45 INFO - PROCESS | 1648 | -------- Summary: end -------- 10:30:45 INFO - PROCESS | 1648 | 10:30:46 INFO - TEST-INFO | 1648: exit 0 10:30:46 INFO - TEST-OK | kraken | took 59154ms 10:30:46 INFO - SUITE-END | took 1177s 10:30:46 INFO - Completed test suite (00:19:37) 10:30:46 INFO - javascript benchmark 10:30:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7907.101724300002, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3009.8495075246233, 3553.0939610399346, 3563.127033876702, 3572.3391172633064, 3611.1152767571934, 5917.497012753915, 6068.453839154476, 6100.725467353968, 6136.355682653324, 6140.355262697414, 6062.18160548327, 6109.358517355669, 6121.571489995691, 6121.724522396492, 6126.877462450749, 5426.810061647853, 5467.617266791326, 5477.424870388591, 5492.368377636583, 5618.269624948772, 5203.427622961472, 5208.479152084799, 5232.843014709546, 5584.385717571064, 5602.551795856342, 5282.102042652758, 5309.681419114865, 5309.734513274321, 5316.548093412064, 5317.8404647860625, 5504.80733174339, 5558.110702287615, 5580.720963951786, 5593.692346920918, 5599.992001439739, 5407.864803379947, 5516.889662206773, 5531.7234138293325, 5543.417941116165, 5589.385167631598, 5841.065429531254, 6153.446189842891, 6157.7229024694, 6176.69116544171, 6227.221597300338, 6265.4361107500545, 6291.150694656254, 6300.905486417708, 6330.620162790201, 6338.366163383671, 6504.804855854332, 6506.707198176094, 6510.869782604369, 6519.152510173694, 6521.9673901630185, 6171.0, 6210.192674952273, 6225.564210505221, 6231.345708700612, 6238.344973777734, 6351.110844481776, 6416.807495775134, 6678.799636010927, 6683.866322673519, 6701.932980670228, 6293.685315734195, 6337.6197428154455, 6365.904511432333, 6386.265579458329, 6387.680615969183, 6471.611703297817, 6516.706748196248, 6521.08704781331, 6527.902081468782, 6535.0850880876715, 6245.875082498324, 6439.9356006440275, 6441.516886233551, 6443.0, 6465.838354041187, 6281.057841323838, 6344.206974128234, 6393.200849893763, 6396.712147953353, 6397.168368112209, 5227.137522308853, 5238.319018527567, 5244.816431424882, 5258.605604579672, 5279.894402111936, 4513.390692256503, 4669.066186762661, 4675.322078298627, 4691.46048204454, 4714.976425117852, 6132.846678833065, 6135.69203737716, 6144.787876364505, 6210.844728881723, 6229.221347331583, 6534.901976470357, 6553.705083271264, 6568.704408301638, 6568.86862262752, 6580.407763301326, 6265.185525881698, 6278.277998030194, 6280.528960327993, 6285.931391663428, 6292.465140463112, 5495.203195536705, 5591.720413979285, 5649.717514124277, 5761.827145185651, 5779.017567013618, 6666.500012499082, 6749.493787965824, 6788.694508747217, 6789.321067893171, 6809.319068093151, 6476.417122459001, 6539.084528166156, 6542.640154791532, 6543.869122617616, 6549.7707580236365, 6451.096846441408, 6726.966365168143, 6801.1158549388265, 6805.9659701701175, 6824.897626535507, 6291.559590828598, 6311.873762524632, 6357.205349331333, 6412.102305677302, 6423.100765892686, 6511.413972742476, 6511.9348806511325, 6521.706523206372, 6524.282328943717, 6533.575317604341, 6169.383061693795, 6202.937970620236, 6211.378862113933, 6236.781712640036, 6305.369463053841, 6340.809775706736, 6343.55595108338, 6347.809565713036, 6355.046742988588, 6357.014662727284, 6084.969575152096, 6101.512952543724, 6106.195129949109, 6140.815775526741, 6289.0, 6192.752289908533, 6200.56596038273, 6254.562180647311, 6261.24865016201, 6269.655168965751, 6253.593516421418, 6268.686565671607, 6271.62370257786, 6275.152854364603, 6306.148669929501], "value": 5984.500702664482, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.9545731798773, 823.3577809308741, 896.6054935828236, 902.832975899459, 910.6812615584543, 40096.0, 40598.0, 40628.79685601572, 40676.79661601695, 40694.79652601733, 42128.0, 42417.78791106048, 42499.57500424995, 42539.14921701564, 42605.7869710651, 7863.292303692667, 9491.857622135656, 9667.12995830375, 9670.903290967106, 9698.90301096987, 7906.802329941769, 9848.212143028577, 11844.466998985066, 12199.024078073777, 12199.390030498484, 11837.822432663517, 11925.0, 11933.701657458547, 11943.34311612861, 11944.940275298655, 11845.822312665317, 11881.0, 11905.0, 11912.821307680391, 11922.940385298105, 11451.541938322458, 11493.885061149365, 11504.482298296596, 11515.539378424854, 11531.76936461266, 39753.40369894454, 39909.00227494307, 39940.800295998626, 39953.0, 39966.200675986605, 3986.80065996699, 4022.275990321741, 4037.596240375968, 4038.6365227129404, 4059.4925634295714, 27653.861730691217, 28297.009604663737, 29641.258968525744, 30204.54693179582, 30509.0, 3157.8263195524237, 3227.2415982244156, 3346.916327091818, 3401.098708842159, 3418.6068602110827, 339307.0, 342300.0, 343033.2848335767, 343841.0, 344528.0, 44197.116057678664, 44628.77685611551, 52796.47203527993, 52825.735871320394, 52974.0, 57555.71222143946, 58197.70901145467, 58265.70867145637, 58300.0, 58373.0, 15026.023308484913, 15396.307166177548, 15756.76364854528, 15778.289976951064, 15794.605134871721, 13293.601191964257, 13309.068365214342, 13342.399592018382, 13342.599722008355, 13344.933275333562, 11259.605913792979, 12001.579944702069, 12281.771822817826, 13165.802512962313, 13306.268155251553, 5093.796248150106, 5938.8218353449465, 5986.0, 6013.639181649115, 6044.766050163142, 980.5587485631495, 986.1322036607739, 1133.9773204535863, 1176.5587904535798, 1220.5544976083843, 30270.243243919078, 30342.089737307917, 30495.542566861513, 30638.38723225523, 30901.69098308988, 1008.0473952115327, 1057.2546354819988, 1074.8495210670512, 1118.7874303882236, 1124.1400328748514, 15464.612037346444, 15520.37918483248, 15576.688466230838, 15786.973846699928, 15885.761713574306, 522954.0, 525187.3740631272, 526566.0, 526649.0, 526702.0, 59652.403475965555, 59914.0, 59926.70036649876, 60135.0, 60152.49618759566, 1441.142520200479, 1470.9117452952858, 1474.351285434427, 1480.592836969842, 1494.9925250373678, 22956.540869182856, 25589.3602659935, 28170.43659126847, 28708.0, 28939.56590651184, 36101.0, 41683.0, 41726.79136604298, 41754.0, 41956.0, 473968.0, 477798.0, 478296.0, 479101.0, 479686.0, 25651.486970260117, 25990.09034683777, 26027.404108116847, 30926.0, 31248.50011998989, 32075.679243208204, 34922.825385873926, 39637.0, 40149.59850401458, 42118.789406052776, 28228.576571351856, 28532.714672853836, 28783.712162878102, 28835.85582072076, 29633.259168520097, 27716.861415692794, 28196.0, 28299.575506367008, 29383.412331753672, 29531.852340738158, 32645.334575530484, 33484.0, 33874.66125338715, 33883.15292117717, 33916.83041584875, 27738.44523109486, 27778.0, 28089.43821123525, 28530.144095677162, 29181.854090729412, 18977.52556186051, 22963.540729185657, 23321.183758568368, 23325.0, 23523.294301170994], "value": 19125.157094676855, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.83335915672455, 438.05817492391367, 444.96217821485175, 445.1630933844372, 459.05892919514986, 19555.804441955577, 21571.892140539294, 22827.31518054459, 23086.30741077768, 23591.528169436602, 18984.0, 23525.41186470339, 24030.0, 24040.639390409113, 24241.757582424172, 6633.20401551812, 6787.151606049244, 6909.861802763941, 7059.39995100417, 7091.149062112528, 6869.313068693115, 6915.377616014558, 6960.095187625601, 6968.651567421609, 6971.930280697205, 6958.930410695904, 7530.548167109991, 7816.257455541714, 7993.200679932019, 7998.1601931797195, 7796.571188584654, 7858.724944626911, 7882.132965373804, 7944.602769861513, 7947.165547617533, 6012.609180403259, 7695.153533111354, 7700.268474494914, 7704.30661240491, 7708.267714567107, 27476.45047099067, 27708.861455692793, 27920.0, 28009.159725208276, 28273.57589636157, 3011.3224524481816, 3044.101989912981, 3088.2125058110264, 3119.937601247985, 3185.665505121975, 16573.585660358465, 17236.224369903386, 17315.913420432942, 17963.550911227194, 17992.1003949802, 2096.6121267565395, 2127.1810353014203, 2130.659094544865, 2132.39226820357, 2205.404540773998, 164839.3516064836, 174503.09938012323, 175203.0, 176413.0, 182204.0, 18744.906275468536, 19660.90169549143, 19830.107645156004, 19852.20591176337, 19951.501212469804, 31004.68995310063, 31430.528542071886, 31515.054548363587, 31592.894248701185, 31612.683873160975, 8416.368772342099, 10545.191213490005, 10797.190210734068, 10823.621173258898, 11019.944900275448, 8973.641054357753, 8999.865002024975, 9015.233705135006, 9191.31065170115, 9201.539923003824, 9019.368644194974, 9201.493917834583, 9268.212201962908, 9288.34981551285, 9304.395214311184, 2858.714128587166, 2985.1343110498146, 3458.152752575635, 3558.092686365012, 3798.2213646203013, 929.3726734454216, 1068.609957365556, 1101.6639924822846, 1108.778244351133, 1125.9303661521424, 21748.13007479683, 22139.778602213773, 22216.555668886533, 22235.777642223693, 22297.219597314015, 1092.137211602825, 1092.7541303206874, 1120.199057673751, 1134.982975255372, 1136.7840110379002, 11040.834387484194, 11403.201775875776, 11543.942280288546, 11650.242734222249, 11652.825207621892, 752761.0, 754965.0, 760917.0, 762508.0, 780362.0, 130510.34744826215, 163968.0, 166345.0, 169714.0, 170358.29641703673, 1189.1794661683412, 1249.2754202562492, 1286.8584455709865, 1342.838859336886, 1344.8318960129984, 19432.611347772683, 19585.314513991943, 19919.302824401075, 20655.96720164016, 20672.276470323468, 67326.31684207934, 67454.0, 68045.0, 68047.97928030984, 69308.0, 96799.0, 97002.54496182704, 97437.02562974564, 97473.51263243638, 100027.99944000934, 11556.075513958695, 11614.187006909435, 11630.94184529072, 11659.125565582446, 11975.161738678209, 12249.326287054297, 13016.8047479286, 13404.530841420894, 13433.932830335785, 13559.45762169502, 11228.831567526657, 11248.212625116163, 11549.249298795552, 11719.531218751154, 11733.296002239893, 8658.177473140042, 10727.946360268148, 10740.892591074302, 10758.46207689628, 10783.299085559414, 9467.715968520955, 11498.885011149781, 11644.35956022427, 11825.467853946766, 11972.461239244429, 11122.277051991594, 11606.535738570363, 11667.941660291644, 11698.122640801803, 11985.400729963641, 9352.67265645699, 10320.638777642747, 11342.20604557673, 11367.658970230907, 11697.649070527897], "value": 12032.114302392018, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.4530079415456, 1532.7164474572205, 1565.193925128559, 1608.7023900578386, 1658.834116588341, 10975.957284058011, 11626.360550169737, 11647.941760291207, 11668.299902005885, 11677.649670509876, 11457.197996140274, 11563.479643416045, 11857.584984525543, 11958.402079895992, 11969.982551483112, 2436.1595249638935, 2504.6368276599883, 2506.4235225898055, 2508.5233805576972, 2512.2337687005456, 2442.2306973303444, 2479.603263477835, 2513.070164039299, 2515.9874200629065, 2520.8109391795597, 2442.2917353967327, 2469.6665950096776, 2495.2264797912703, 2496.2012156110054, 2499.0128899084852, 2418.286605451396, 2436.098643501898, 2460.175841093227, 2464.3592665906813, 2469.555480013606, 2453.5092981403614, 2475.232677869866, 2475.913343033003, 2486.8880900359345, 2488.35302821266, 11296.943515282454, 11474.0, 11500.482478288497, 11505.252158609746, 11525.36610486423, 5872.823815285506, 6065.090236464522, 6067.878642427171, 6072.05883088122, 6076.301225359096, 3608.4948107265004, 3716.1267102230954, 3738.140227747606, 3797.791121488317, 3810.599887011879, 1272.28116114396, 1744.9825501744947, 1925.740025096608, 1927.2002119120548, 1941.1264930781206, 14076.648083797885, 14362.712745745132, 14714.926425367805, 16244.593885152966, 16406.83593164065, 4905.092557876804, 5065.518775716301, 5082.364704411949, 5095.745212739348, 5104.719240441737, 13215.074944753967, 13219.603411897466, 13231.735365292832, 13232.20606763578, 13232.470701171846, 5177.767000484987, 5333.813316533902, 5349.66353693157, 5391.595630327741, 6107.358727333566, 5133.307003554472, 5316.6544174628525, 5543.1408131739645, 5578.107502799533, 5613.0, 3967.3850553164307, 3978.224246271949, 4066.4510291110914, 4068.6541643960595, 4074.694397920168, 1044.206403133624, 1055.2244100586217, 1070.4754670211696, 1073.2326386633595, 1073.4042606353394, 957.2772556719632, 972.99027009729, 982.7641366072091, 996.5067291690659, 1003.2225025605214, 6899.793006209822, 7006.859862802818, 7073.929260707327, 7121.964390178119, 7134.464915131386, 933.6498812945146, 993.344392700814, 1008.3748076192808, 1009.222898368267, 1086.6794295682791, 4334.089841133335, 4342.82628694855, 4459.1304695584695, 4463.754493502888, 4677.041206552649, 13498.86501134976, 13902.721945561234, 13936.163830170222, 14042.227677477633, 14064.226467544384, 13652.453901843815, 13760.243186624832, 14016.0, 14024.579262622137, 14033.929830350782, 10249.795004099877, 10508.211884108723, 10509.842352364567, 10513.579456821795, 10538.683839484827, 6793.932060679527, 6844.452443804584, 6860.965695171492, 6900.309969003059, 6982.162140543167, 10952.780944381228, 11306.982371586597, 12667.619971400873, 12698.555550555686, 12724.300163491096, 12043.397830108635, 12267.815982760087, 12800.35998200105, 12962.416691248727, 13028.54400095992, 9313.674021409219, 9317.813643727222, 9491.620335186515, 9568.808623827344, 9579.856302155335, 9616.75958101053, 9778.65774697882, 10288.742781430525, 10299.794004120025, 10507.054365107177, 8560.0, 8643.0, 8764.956175219084, 8865.468071915706, 8929.24101451358, 8496.490210587384, 8571.0, 8591.6992905248, 8631.482111073105, 8662.82674346497, 8067.757967260992, 8116.066652334821, 8216.137305582828, 8223.383246256675, 8227.629756660845, 5208.687478751287, 5909.734061967136, 5956.778860333535, 6061.787837425669, 6101.908471372844, 6017.638941663514, 6033.758649653964, 6108.5723999319625, 6222.875542489215, 6353.777617783356], "value": 5342.150750272281, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.1819733152375, 396.32031066720566, 400.7776282338867, 403.5077205808912, 407.2974119643615, 4550.269838097149, 5253.579713622906, 5289.709066001373, 5342.866428339294, 5365.839024829252, 4482.372467854495, 4583.487449141783, 4632.675712700104, 5041.395032596093, 5187.584993200544, 3782.3759079751876, 4036.7981600919984, 4078.1843631273714, 4121.319982202933, 4135.917281654365, 3431.3308904763458, 3640.3447379471686, 3832.310184166849, 4042.7147223942716, 4103.8563650272245, 3696.445533170019, 3826.5982071882468, 3922.6469617734397, 4135.028268356934, 4155.542890282067, 3579.1410061585293, 3750.7562008469363, 3914.902127446808, 4007.5391329997133, 4023.0948036691802, 3631.8184090795353, 3636.690881275095, 3663.3222853772136, 3668.578113516953, 3754.9436758448373, 4875.804967801284, 5050.191969284933, 5081.339425874649, 5091.745412729349, 5185.766640501187, 4362.672799540015, 4484.148011877733, 4701.990725935404, 4748.358971538867, 4799.2801079837955, 4731.6578293744815, 4817.56641902227, 5014.523620256106, 5019.895622962942, 5576.247206627094, 3362.512435696835, 3418.3505134024704, 3441.7609660522444, 4057.1277175407135, 4105.5894410559, 4465.218586747306, 5135.922961155586, 5634.32388113429, 5710.857228569319, 5819.67991760453, 4849.878753031202, 4854.563089321978, 4901.828436004723, 4906.484819093944, 4920.114379411741, 4390.407295015196, 4829.1307564638, 5003.524665156804, 5024.371953505812, 5025.597952163891, 4261.552536983572, 4875.317455556225, 4935.593355893553, 5207.52642494812, 5207.973960130175, 4987.376577927759, 5015.297858299841, 5443.537299329522, 5455.918161227585, 5569.359523654751, 1492.2016721054183, 1594.6970075685583, 1710.7006273902266, 1711.9743203851951, 1729.5503169176104, 1218.9009047460572, 1264.8616245379233, 1280.7630588341187, 1385.840628327735, 1402.7194561087824, 4411.735295882258, 5025.4974502550185, 5184.677907133732, 5247.425772268304, 5267.9736601316745, 4925.802967881316, 5187.870303242374, 5591.210812540029, 5787.913181302284, 5799.507041901401, 4531.954680453153, 4798.736069516141, 4842.128416884994, 5058.231617445027, 5319.627626066138, 2354.893200195905, 2465.878025498394, 2509.86195759235, 2734.2754170144926, 2865.323785585456, 5068.41713202979, 5813.82558523245, 5823.621464604787, 5841.853953651193, 5875.942330380487, 4911.852644420673, 5169.0, 5231.581473482112, 5366.946330536644, 5483.862903427446, 4936.876578085505, 5153.587712982952, 5336.839894803162, 5931.644101353846, 5978.671173085522, 4546.886012926854, 4782.713037217778, 5085.4914508548845, 5578.525825304894, 5604.8038318658655, 4737.981334013204, 5035.104239343129, 5239.947600524099, 5479.726013699379, 5551.306086739158, 5134.255532947627, 5559.555235581063, 5571.220029195997, 5808.883822323445, 5933.110033495011, 3894.7857867817543, 4063.3904914261916, 4176.686748493815, 4501.639868810553, 4506.459224893034, 5037.899242015213, 5638.716319890451, 5671.262735844314, 5698.182217913924, 5826.912596310974, 4684.789184486638, 4845.491223421631, 5014.874628134326, 5126.56424203932, 5480.72596370172, 4744.169770290255, 5154.974225128851, 5465.196485159967, 5535.982889325408, 5565.582581306499, 5039.874003149951, 5357.866053348697, 5391.487808658171, 5393.730313484389, 5402.75687594067, 4989.353513340661, 5003.574696150868, 5435.755391007335, 5581.6371935824045, 5639.520640745583, 5052.520010598987, 5141.560363098189, 5405.216313598421, 5454.454554544673, 5470.350202328148], "value": 4168.668255873343, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.3870833978649, 803.1326167738843, 878.3061381508606, 880.8872216916002, 909.1226965977833, 15530.689386212269, 16882.0, 17053.317867285325, 17138.0, 17189.656206875872, 15385.0, 15533.844661553381, 15752.527424177264, 15936.681266374666, 16254.918725406385, 995.21378111292, 996.1234113979724, 996.9551370188323, 1000.1598657128011, 1001.234055947201, 990.8315586350337, 1000.8999100090006, 1032.5972870580479, 1034.3690348887174, 1035.4098164046497, 1074.087026027874, 1075.7794652096302, 1076.101455284838, 1078.4607696151925, 1078.7195329214383, 1071.769569542552, 1073.2809017957948, 1074.4466599701161, 1074.6346242277584, 1074.8280275155937, 797.948133371329, 798.9800254993613, 799.0052384780927, 799.0092285565914, 799.9680012799481, 17383.73924391135, 17418.564535886577, 17467.213975371138, 18109.366172184044, 18323.816761832346, 14630.26848657563, 14681.045732027384, 14766.557003289918, 14806.0, 14812.111273323635, 11918.821217681741, 11940.0, 12064.396780160956, 12122.39388030595, 12304.753904921941, 3336.6830151135605, 3768.3405404054456, 3868.9226215475815, 3909.2181563687377, 4027.8993025174314, 116415.4179229107, 116462.41768791102, 119297.0, 120219.0, 122664.0, 8693.43492672987, 8781.736547903573, 8809.911900880908, 8812.91187088121, 9026.097390260922, 19764.60470790576, 23812.64281035786, 24126.276211713677, 24163.39591510191, 24173.879130604586, 6809.353111454404, 7784.104827944859, 7827.1390147083775, 8066.072401673765, 8182.7545173644885, 4398.097691469323, 4508.143452743968, 4565.497795242521, 4610.746408947473, 4746.952530474651, 3652.19651676636, 3680.1351682354625, 3705.4627079073384, 3746.981265093657, 3757.981210093932, 485.5435890263141, 560.8054843184074, 563.9661620302795, 578.3580225949192, 580.686429328158, 660.3693472733528, 723.2333726250191, 742.3479348196669, 747.1407880936857, 770.3759954436924, 10217.438040907673, 10241.334313269614, 10269.7432564185, 10518.789624207473, 10588.894111058946, 727.2654618835015, 730.9780706578811, 736.3851184261202, 743.2827321634649, 743.498133769782, 4905.3132561441425, 5207.843764687065, 5210.400803907523, 5211.739413029333, 5219.608529360313, 104183.0, 110013.44993275142, 114113.0, 114890.0, 118010.81989179998, 89153.0, 94922.0, 95316.0, 97185.0, 97896.0, 83942.74085888716, 84453.0, 84650.15349846422, 85398.14601853902, 87052.1294787044, 9468.289878259297, 9489.85765213536, 9920.355176913477, 10054.798904022025, 10101.49492525356, 48401.54795356145, 49878.0, 51721.7413912928, 52173.7391313041, 52255.21617175669, 60631.69684151551, 67290.32709673037, 71380.64309678625, 72390.63804681154, 74623.62688186525, 13350.866491334962, 13548.59354219375, 13848.0, 14123.223222722438, 14435.566932992027, 15572.454964076203, 15710.0, 15992.200389980222, 16703.91648041752, 16833.831661683227, 13000.674983125498, 13152.342382880626, 13497.730045399234, 14118.364673589507, 14161.575152745434, 14325.78511322352, 14692.853071469148, 14842.332095055532, 14848.034877732913, 14982.026168299026, 13441.596752097452, 13607.0, 13926.58220253394, 14605.269736512919, 14957.326920288395, 8044.178188016533, 9842.21262299, 10161.339512931636, 10367.429791361548, 10663.840042399215, 9982.650607228712, 10363.952675743856, 11885.108616853944, 12064.095192860746, 12124.757504849676], "value": 7968.449175554638, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1424.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 119.0, 119.0, 118.0, 119.0, 119.0, 119.0, 114.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 108.0, 144.0, 111.0, 109.0, 108.0, 108.0, 126.0, 108.0], "value": 117.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 181.0, 199.0, 261.0, 202.0, 185.0, 186.0, 183.0, 185.0], "value": 195.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 68.0, 113.0, 92.0, 83.0, 64.0, 59.0, 75.0, 69.0], "value": 76.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 85.0, 67.0, 68.0, 68.0, 81.0, 67.0, 68.0, 83.0], "value": 74.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 87.0, 88.0, 88.0, 89.0, 88.0, 87.0, 87.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 93.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 98.0, 132.0, 84.0, 85.0, 83.0, 83.0, 82.0, 83.0], "value": 89.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 66.0, 61.0, 63.0, 62.0, 61.0, 63.0, 63.0, 64.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 64.0, 56.0, 58.0, 63.0, 58.0, 57.0, 57.0, 57.0, 62.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 81.0, 82.0, 82.0, 83.0, 83.0, 86.0, 83.0, 108.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 135.0, 136.0, 137.0, 138.0, 125.0, 147.0, 158.0, 136.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 165.0, 162.0, 160.0, 160.0, 162.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 63.0, 63.0, 62.0, 65.0, 76.0, 72.0], "value": 65.6, "unit": "score"}]}]} 10:30:46 INFO - Return code: 0 10:30:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:30:46 INFO - # TBPL SUCCESS # 10:30:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:30:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:30:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:30:46 INFO - 2017-04-21 10:30:46.912 screenresolution[1653:9769] starting screenresolution argv=screenresolution get 10:30:46 INFO - 2017-04-21 10:30:46.915 screenresolution[1653:9769] Display 0: 1600x1200x32@60 10:30:46 INFO - 2017-04-21 10:30:46.921 screenresolution[1654:9772] starting screenresolution argv=screenresolution list 10:30:46 INFO - Available Modes on Display 0 10:30:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:30:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:30:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:30:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:30:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:30:47 INFO - Intel Iris: 10:30:47 INFO - Chipset Model: Intel Iris 10:30:47 INFO - Type: GPU 10:30:47 INFO - Bus: Built-In 10:30:47 INFO - VRAM (Dynamic, Max): 1536 MB 10:30:47 INFO - Vendor: Intel (0x8086) 10:30:47 INFO - Device ID: 0x0a2e 10:30:47 INFO - Revision ID: 0x0009 10:30:47 INFO - Displays: 10:30:47 INFO - Display: 10:30:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:30:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:30:47 INFO - Display Serial Number: 1600x1200 60 10:30:47 INFO - Main Display: Yes 10:30:47 INFO - Mirror: Off 10:30:47 INFO - Online: Yes 10:30:47 INFO - Rotation: Supported 10:30:47 INFO - Return code: 0 10:30:47 INFO - Running post-action listener: _resource_record_post_action 10:30:47 INFO - [mozharness: 2017-04-21 17:30:47.165339Z] Finished run-tests step (success) 10:30:47 INFO - Running post-run listener: _resource_record_post_run 10:30:47 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 39576576; Write bytes: 422391808; Read time: 389; Write time: 1798 10:30:47 INFO - TinderboxPrint: CPU usage
53.7% 10:30:47 INFO - TinderboxPrint: I/O read bytes / time
39,576,576 / 389 10:30:47 INFO - TinderboxPrint: I/O write bytes / time
422,391,808 / 1,798 10:30:47 INFO - TinderboxPrint: CPU idle
2,210.8 (46.3%) 10:30:47 INFO - TinderboxPrint: CPU system
947.7 (19.9%) 10:30:47 INFO - TinderboxPrint: CPU user
1,615.2 (33.8%) 10:30:47 INFO - TinderboxPrint: Swap in / out
161,411,072 / 0 10:30:47 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 119560704; Write bytes: 114509824; Read time: 10824; Write time: 276 10:30:47 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 37426176; Write bytes: 296687616; Read time: 364; Write time: 1484 10:30:47 INFO - Running post-run listener: _upload_blobber_files 10:30:47 INFO - Blob upload gear active. 10:30:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:30:47 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 10:30:47 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'] 10:30:47 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 10:30:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:30:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:30:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:30:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:48 INFO - (blobuploader) - INFO - Done attempting. 10:30:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:30:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:30:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:49 INFO - (blobuploader) - INFO - Done attempting. 10:30:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:30:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:30:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:52 INFO - (blobuploader) - INFO - Done attempting. 10:30:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:30:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:54 INFO - (blobuploader) - INFO - Done attempting. 10:30:54 INFO - (blobuploader) - INFO - Iteration through files over. 10:30:54 INFO - Return code: 0 10:30:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:30:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:30:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3de81caaa782935114094950b7c1480b575ee5ae18bbafa907cac932c6f2cbd1d4ccbb70f530cfb9d016722a6919bce08d046c38a36b25f05b0e6004f39bbec7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5b75131f54a4e85328ffcd31e9eba8b0d13bd2d8e3c63a9df009ffa28b2a01db551733bf4747bf00cb2d60fcf17eeb23f2303014112f3c6b0ecb89b0cbc84f3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3302c2bd2c12906f496f27a7b110b9d3cf1f604a80bc2d1e812bfc11c0ef38f4b27210f22965297a7ef2322505c11d25a29bea845d4a49a99812276bf68f770f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26cbf00b720f1179c096dda250aa8592d93376fde1142c9390cc0eeb50ac3c98b4be9bc1b09b6d520a40acf9d08c871b3ed087a2b962eccb7386f1fe391885de"} 10:30:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:30:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:30:54 INFO - Contents: 10:30:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3de81caaa782935114094950b7c1480b575ee5ae18bbafa907cac932c6f2cbd1d4ccbb70f530cfb9d016722a6919bce08d046c38a36b25f05b0e6004f39bbec7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5b75131f54a4e85328ffcd31e9eba8b0d13bd2d8e3c63a9df009ffa28b2a01db551733bf4747bf00cb2d60fcf17eeb23f2303014112f3c6b0ecb89b0cbc84f3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3302c2bd2c12906f496f27a7b110b9d3cf1f604a80bc2d1e812bfc11c0ef38f4b27210f22965297a7ef2322505c11d25a29bea845d4a49a99812276bf68f770f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26cbf00b720f1179c096dda250aa8592d93376fde1142c9390cc0eeb50ac3c98b4be9bc1b09b6d520a40acf9d08c871b3ed087a2b962eccb7386f1fe391885de"} 10:30:54 INFO - Running post-run listener: copy_logs_to_upload_dir 10:30:54 INFO - Copying logs to upload dir... 10:30:54 INFO - mkdir: /builds/slave/test/build/upload/logs 10:30:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.528824 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-04-21 10:30:54.382678) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 10:30:54.386387) ========= 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.L9PsZFii3s/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.QJeTRj7ECk/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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/3de81caaa782935114094950b7c1480b575ee5ae18bbafa907cac932c6f2cbd1d4ccbb70f530cfb9d016722a6919bce08d046c38a36b25f05b0e6004f39bbec7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5b75131f54a4e85328ffcd31e9eba8b0d13bd2d8e3c63a9df009ffa28b2a01db551733bf4747bf00cb2d60fcf17eeb23f2303014112f3c6b0ecb89b0cbc84f3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3302c2bd2c12906f496f27a7b110b9d3cf1f604a80bc2d1e812bfc11c0ef38f4b27210f22965297a7ef2322505c11d25a29bea845d4a49a99812276bf68f770f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26cbf00b720f1179c096dda250aa8592d93376fde1142c9390cc0eeb50ac3c98b4be9bc1b09b6d520a40acf9d08c871b3ed087a2b962eccb7386f1fe391885de"} build_url:https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011137 build_url: 'https://queue.taskcluster.net/v1/task/K0JdtRjhR1uxtH50ff1B0Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3de81caaa782935114094950b7c1480b575ee5ae18bbafa907cac932c6f2cbd1d4ccbb70f530cfb9d016722a6919bce08d046c38a36b25f05b0e6004f39bbec7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5b75131f54a4e85328ffcd31e9eba8b0d13bd2d8e3c63a9df009ffa28b2a01db551733bf4747bf00cb2d60fcf17eeb23f2303014112f3c6b0ecb89b0cbc84f3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3302c2bd2c12906f496f27a7b110b9d3cf1f604a80bc2d1e812bfc11c0ef38f4b27210f22965297a7ef2322505c11d25a29bea845d4a49a99812276bf68f770f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26cbf00b720f1179c096dda250aa8592d93376fde1142c9390cc0eeb50ac3c98b4be9bc1b09b6d520a40acf9d08c871b3ed087a2b962eccb7386f1fe391885de"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 10:30:54.421634) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:30:54.421975) ========= 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.L9PsZFii3s/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.QJeTRj7ECk/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005010 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:30:54.470691) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 10:30:54.471016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 10:30:54.471320) ========= ========= Total master_lag: 0.18 =========