builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0037 starttime: 1493425889.16 results: success (0) buildid: 20170428170826 builduid: 5b101bf160f14c5e9f1a218b2a9f2f31 revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:31:29.160079) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:31:29.160573) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:31:29.160881) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:31:29.186775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:31:29.187166) ========= 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.JVcGyCEIKi/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.q8bkt4qvys/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-28 17:31:29-- 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% 9.66M=0.001s 2017-04-28 17:31:29 (9.66 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092693 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:31:29.304314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:31:29.304653) ========= 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.JVcGyCEIKi/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.q8bkt4qvys/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.022950 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:31:29.353702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:31:29.354419) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b3b32894d9326d147238d9f071e1814ab3fdc850 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b3b32894d9326d147238d9f071e1814ab3fdc850 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JVcGyCEIKi/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.q8bkt4qvys/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-28 17:31:29,441 truncating revision to first 12 chars 2017-04-28 17:31:29,442 Setting DEBUG logging. 2017-04-28 17:31:29,442 attempt 1/10 2017-04-28 17:31:29,442 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b3b32894d932?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 17:31:30,908 unpacking tar archive at: mozilla-central-b3b32894d932/testing/mozharness/ program finished with exit code 0 elapsedTime=1.731703 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:31:31.112313) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:31:31.112781) ========= script_repo_revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:31:31.113335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:31:31.113755) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:31:31.135002) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-28 17:31:31.135403) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JVcGyCEIKi/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.q8bkt4qvys/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 17:31:31 INFO - MultiFileLogger online at 20170428 17:31:31 in /builds/slave/test 17:31:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:31:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:31:31 INFO - {'append_to_log': False, 17:31:31 INFO - 'base_work_dir': '/builds/slave/test', 17:31:31 INFO - 'blob_upload_branch': 'Firefox', 17:31:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:31:31 INFO - 'branch': 'Firefox', 17:31:31 INFO - 'buildbot_json_path': 'buildprops.json', 17:31:31 INFO - 'config_files': ('talos/mac_config.py',), 17:31:31 INFO - 'default_actions': ('clobber', 17:31:31 INFO - 'read-buildbot-config', 17:31:31 INFO - 'download-and-extract', 17:31:31 INFO - 'populate-webroot', 17:31:31 INFO - 'create-virtualenv', 17:31:31 INFO - 'install', 17:31:31 INFO - 'run-tests'), 17:31:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:31:31 INFO - 'download_minidump_stackwalk': True, 17:31:31 INFO - 'download_symbols': 'ondemand', 17:31:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:31:31 INFO - 'tooltool.py': '/tools/tooltool.py', 17:31:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:31:31 INFO - '/tools/misc-python/virtualenv.py')}, 17:31:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:31:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:31:31 INFO - 'gecko_profile': False, 17:31:31 INFO - 'gecko_profile_interval': 0, 17:31:31 INFO - 'installer_path': 'installer.exe', 17:31:31 INFO - 'log_level': 'info', 17:31:31 INFO - 'log_name': 'talos', 17:31:31 INFO - 'log_to_console': True, 17:31:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:31:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:31:31 INFO - 'opt_config_files': (), 17:31:31 INFO - 'pip_index': False, 17:31:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:31:31 INFO - 'cmd': ('bash', 17:31:31 INFO - '-c', 17:31:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:31:31 INFO - 'enabled': True, 17:31:31 INFO - 'halt_on_failure': False, 17:31:31 INFO - 'name': 'check_screen_resolution'},), 17:31:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:31:31 INFO - 'cmd': ('bash', 17:31:31 INFO - '-c', 17:31:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:31:31 INFO - 'enabled': True, 17:31:31 INFO - 'halt_on_failure': False, 17:31:31 INFO - 'name': 'check_screen_resolution'},), 17:31:31 INFO - 'run_cmd_checks_enabled': True, 17:31:31 INFO - 'suite': 'dromaeojs', 17:31:31 INFO - 'system_bits': '32', 17:31:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:31:31 INFO - 'title': 't-yosemite-r7-0037', 17:31:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:31:31 INFO - 'use_talos_json': True, 17:31:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:31:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:31:31 INFO - 'work_dir': 'build'} 17:31:31 INFO - [mozharness: 2017-04-29 00:31:31.345860Z] Running clobber step. 17:31:31 INFO - Running pre-action listener: _resource_record_pre_action 17:31:31 INFO - Running main action method: clobber 17:31:31 INFO - rmtree: /builds/slave/test/build 17:31:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:31:34 INFO - Running post-action listener: _resource_record_post_action 17:31:34 INFO - [mozharness: 2017-04-29 00:31:34.695118Z] Finished clobber step (success) 17:31:34 INFO - [mozharness: 2017-04-29 00:31:34.695387Z] Running read-buildbot-config step. 17:31:34 INFO - Running pre-action listener: _resource_record_pre_action 17:31:34 INFO - Running main action method: read_buildbot_config 17:31:34 INFO - Using buildbot properties: 17:31:34 INFO - { 17:31:34 INFO - "project": "", 17:31:34 INFO - "product": "firefox", 17:31:34 INFO - "script_repo_revision": "production", 17:31:34 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:31:34 INFO - "repository": "", 17:31:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:31:34 INFO - "buildid": "20170428170826", 17:31:34 INFO - "stage_platform": "macosx64", 17:31:34 INFO - "basedir": "/builds/slave/test", 17:31:34 INFO - "buildnumber": 52, 17:31:34 INFO - "platform": "yosemite_r7", 17:31:34 INFO - "mozci_request": { 17:31:34 INFO - "priority": 0, 17:31:34 INFO - "type": "trigger_all_talos_jobs", 17:31:34 INFO - "times": 6 17:31:34 INFO - }, 17:31:34 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:31:34 INFO - "slavebuilddir": "test", 17:31:34 INFO - "branch": "mozilla-central", 17:31:34 INFO - "revision": "b3b32894d9326d147238d9f071e1814ab3fdc850", 17:31:34 INFO - "slavename": "t-yosemite-r7-0037", 17:31:34 INFO - "builduid": "5b101bf160f14c5e9f1a218b2a9f2f31", 17:31:34 INFO - "repo_path": "mozilla-central" 17:31:34 INFO - } 17:31:34 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg. 17:31:34 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json. 17:31:34 INFO - Running post-action listener: _resource_record_post_action 17:31:34 INFO - [mozharness: 2017-04-29 00:31:34.702140Z] Finished read-buildbot-config step (success) 17:31:34 INFO - [mozharness: 2017-04-29 00:31:34.702337Z] Running download-and-extract step. 17:31:34 INFO - Running pre-action listener: _resource_record_pre_action 17:31:34 INFO - Running main action method: download_and_extract 17:31:34 INFO - mkdir: /builds/slave/test/build/tests 17:31:34 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')]} 17:31:34 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json 17:31:34 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 17:31:35 INFO - Downloaded 1325 bytes. 17:31:35 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:31:35 INFO - Using the following test package requirements: 17:31:35 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:31:35 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:31:35 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:31:35 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:31:35 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:31:35 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:31:35 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:31:35 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:31:35 INFO - u'jsshell-mac.zip'], 17:31:35 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:31:35 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:31:35 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:31:35 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:31:35 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:31:35 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:31:35 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:31:35 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:31:35 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:31:35 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:31:35 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:31:35 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:31:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip 17:31:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:31:35 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:31:36 INFO - Content-Length response header: 52698163 17:31:36 INFO - Bytes received: 52698163 17:31:52 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:31:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip 17:31:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:31:52 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:31:53 INFO - Content-Length response header: 52698163 17:31:53 INFO - Bytes received: 52698163 17:32:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.talos.tests.zip 17:32:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:32:08 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:32:09 INFO - Content-Length response header: 14408809 17:32:09 INFO - Bytes received: 14408809 17:32:10 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')]} 17:32:10 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:32:10 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:32:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 17:32:11 INFO - Downloaded 71219323 bytes. 17:32:11 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:32:11 INFO - mkdir: /builds/slave/test/properties 17:32:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:32:11 INFO - Writing to file /builds/slave/test/properties/build_url 17:32:11 INFO - Contents: 17:32:11 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:32:11 INFO - Running post-action listener: _resource_record_post_action 17:32:11 INFO - Running post-action listener: set_extra_try_arguments 17:32:11 INFO - [mozharness: 2017-04-29 00:32:11.852319Z] Finished download-and-extract step (success) 17:32:11 INFO - [mozharness: 2017-04-29 00:32:11.852462Z] Running populate-webroot step. 17:32:11 INFO - Running pre-action listener: _resource_record_pre_action 17:32:11 INFO - Running main action method: populate_webroot 17:32:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:32:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:32:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:32:11 INFO - '--tppagecycles', 17:32:11 INFO - '7'], 17:32:11 INFO - 'tests': ['tsvgm']}}, 17:32:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:32:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:32:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:32:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:32:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:32:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:32:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:32:11 INFO - 'talos_options': ['--disable-e10s'], 17:32:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:32:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:32:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:32:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:32:11 INFO - 'talos_options': ['--disable-e10s'], 17:32:11 INFO - 'tests': ['damp', 'tps']}, 17:32:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:32:11 INFO - 'tests': ['damp', 'tps']}, 17:32:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:32:11 INFO - 'tests': ['dromaeo_dom']}, 17:32:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:32:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:32:11 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:32:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:32:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:32:11 INFO - 'tests': ['a11yr', 17:32:11 INFO - 'ts_paint', 17:32:11 INFO - 'tpaint', 17:32:11 INFO - 'sessionrestore', 17:32:11 INFO - 'sessionrestore_no_auto_restore', 17:32:11 INFO - 'tabpaint']}, 17:32:11 INFO - 'other-e10s': {'tests': ['a11yr', 17:32:11 INFO - 'ts_paint', 17:32:11 INFO - 'tpaint', 17:32:11 INFO - 'sessionrestore', 17:32:11 INFO - 'sessionrestore_no_auto_restore', 17:32:11 INFO - 'tabpaint']}, 17:32:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:32:11 INFO - 'ts_paint', 17:32:11 INFO - 'tpaint', 17:32:11 INFO - 'sessionrestore', 17:32:11 INFO - 'sessionrestore_no_auto_restore', 17:32:11 INFO - 'tabpaint']}, 17:32:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:32:11 INFO - 'ts_paint', 17:32:11 INFO - 'tpaint', 17:32:11 INFO - 'sessionrestore', 17:32:11 INFO - 'sessionrestore_no_auto_restore', 17:32:11 INFO - 'tabpaint']}, 17:32:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:32:11 INFO - 'tests': ['a11yr', 17:32:11 INFO - 'ts_paint', 17:32:11 INFO - 'tpaint', 17:32:11 INFO - 'sessionrestore', 17:32:11 INFO - 'sessionrestore_no_auto_restore', 17:32:11 INFO - 'tabpaint']}, 17:32:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:32:11 INFO - 'tests': ['a11yr', 17:32:11 INFO - 'ts_paint', 17:32:11 INFO - 'tpaint', 17:32:11 INFO - 'sessionrestore', 17:32:11 INFO - 'sessionrestore_no_auto_restore', 17:32:11 INFO - 'tabpaint']}, 17:32:11 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:32:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:32:11 INFO - 'bloom_basic_ref']}, 17:32:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:32:11 INFO - 'tests': ['tsvgx', 17:32:11 INFO - 'tsvgr_opacity', 17:32:11 INFO - 'tart', 17:32:11 INFO - 'tscrollx', 17:32:11 INFO - 'cart', 17:32:11 INFO - 'tsvg_static']}, 17:32:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:32:11 INFO - 'tsvgr_opacity', 17:32:11 INFO - 'tart', 17:32:11 INFO - 'tscrollx', 17:32:11 INFO - 'cart', 17:32:11 INFO - 'tsvg_static']}, 17:32:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:32:11 INFO - 'talos_options': ['--disable-e10s'], 17:32:11 INFO - 'tests': ['tp5o']}, 17:32:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:32:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:32:11 INFO - 'talos_options': ['--disable-e10s', 17:32:11 INFO - '--xperf_path', 17:32:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:32:11 INFO - 'tests': ['tp5n']}, 17:32:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:32:11 INFO - 'talos_options': ['--xperf_path', 17:32:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:32:11 INFO - 'tests': ['tp5n']}}, 17:32:11 INFO - 'talos.zip': {'path': '', 17:32:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:32:11 INFO - Running post-action listener: _resource_record_post_action 17:32:11 INFO - [mozharness: 2017-04-29 00:32:11.871473Z] Finished populate-webroot step (success) 17:32:11 INFO - [mozharness: 2017-04-29 00:32:11.871586Z] Running create-virtualenv step. 17:32:11 INFO - Running pre-action listener: _resource_record_pre_action 17:32:11 INFO - Running main action method: create_virtualenv 17:32:11 INFO - Creating virtualenv /builds/slave/test/build/venv 17:32:11 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 17:32:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:32:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:32:11 INFO - Using real prefix '/tools/python27' 17:32:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:32:12 INFO - Installing distribute.............................................................................................................................................................................................done. 17:32:15 INFO - Installing pip.................done. 17:32:15 INFO - Return code: 0 17:32:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:32:15 INFO - Reading from file tmpfile_stdout 17:32:15 INFO - Output received: 17:32:15 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) 17:32:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:32:15 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')]} 17:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:15 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')]} 17:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:15 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 0x109d6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefea4afe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ad30>, '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 0x109a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b3fbe8>, '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.JVcGyCEIKi/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.q8bkt4qvys/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 17:32:15 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 17:32:15 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 17:32:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JVcGyCEIKi/Render', 17:32:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:32:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:32:15 INFO - 'HOME': '/Users/cltbld', 17:32:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:32:15 INFO - 'LOGNAME': 'cltbld', 17:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:15 INFO - 'MOZ_NO_REMOTE': '1', 17:32:15 INFO - 'NO_EM_RESTART': '1', 17:32:15 INFO - 'PAGER': '/bin/cat', 17:32:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:15 INFO - 'PWD': '/builds/slave/test', 17:32:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:32:15 INFO - 'SHELL': '/bin/bash', 17:32:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q8bkt4qvys/Listeners', 17:32:15 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 17:32:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:32:15 INFO - 'USER': 'cltbld', 17:32:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:32:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:15 INFO - 'XPC_FLAGS': '0x0', 17:32:15 INFO - 'XPC_SERVICE_NAME': '0', 17:32:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:16 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 17:32:16 INFO - Cleaning up... 17:32:16 INFO - Return code: 0 17:32:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109d6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefea4afe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ad30>, '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 0x109a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b3fbe8>, '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.JVcGyCEIKi/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.q8bkt4qvys/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 17:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:32:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JVcGyCEIKi/Render', 17:32:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:32:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:32:16 INFO - 'HOME': '/Users/cltbld', 17:32:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:32:16 INFO - 'LOGNAME': 'cltbld', 17:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:16 INFO - 'MOZ_NO_REMOTE': '1', 17:32:16 INFO - 'NO_EM_RESTART': '1', 17:32:16 INFO - 'PAGER': '/bin/cat', 17:32:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:16 INFO - 'PWD': '/builds/slave/test', 17:32:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:32:16 INFO - 'SHELL': '/bin/bash', 17:32:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q8bkt4qvys/Listeners', 17:32:16 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 17:32:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:32:16 INFO - 'USER': 'cltbld', 17:32:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:32:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:16 INFO - 'XPC_FLAGS': '0x0', 17:32:16 INFO - 'XPC_SERVICE_NAME': '0', 17:32:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:16 INFO - Downloading/unpacking psutil>=3.1.1 17:32:16 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 17:32:16 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 17:32:16 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 17:32:16 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 17:32:16 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 17:32:16 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 17:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:32:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:32:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:32:20 INFO - Installing collected packages: psutil 17:32:20 INFO - Running setup.py install for psutil 17:32:20 INFO - building 'psutil._psutil_osx' extension 17:32:20 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 17:32:20 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 17:32:20 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 17:32:20 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 17:32:20 INFO - building 'psutil._psutil_posix' extension 17:32:20 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 17:32:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:32:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:32:20 INFO - ^ 17:32:20 INFO - 1 warning generated. 17:32:20 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 17:32:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:32:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:32:20 INFO - Successfully installed psutil 17:32:20 INFO - Cleaning up... 17:32:21 INFO - Return code: 0 17:32:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefea4afe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ad30>, '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 0x109a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b3fbe8>, '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.JVcGyCEIKi/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.q8bkt4qvys/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 17:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:32:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JVcGyCEIKi/Render', 17:32:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:32:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:32:21 INFO - 'HOME': '/Users/cltbld', 17:32:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:32:21 INFO - 'LOGNAME': 'cltbld', 17:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:21 INFO - 'MOZ_NO_REMOTE': '1', 17:32:21 INFO - 'NO_EM_RESTART': '1', 17:32:21 INFO - 'PAGER': '/bin/cat', 17:32:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:21 INFO - 'PWD': '/builds/slave/test', 17:32:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:32:21 INFO - 'SHELL': '/bin/bash', 17:32:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q8bkt4qvys/Listeners', 17:32:21 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 17:32:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:32:21 INFO - 'USER': 'cltbld', 17:32:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:32:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:21 INFO - 'XPC_FLAGS': '0x0', 17:32:21 INFO - 'XPC_SERVICE_NAME': '0', 17:32:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:32:23 INFO - Installing collected packages: mozsystemmonitor 17:32:23 INFO - Running setup.py install for mozsystemmonitor 17:32:24 INFO - Successfully installed mozsystemmonitor 17:32:24 INFO - Cleaning up... 17:32:24 INFO - Return code: 0 17:32:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:32: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')]} 17:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32: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')]} 17:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32: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', '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 0x109d6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefea4afe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ad30>, '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 0x109a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b3fbe8>, '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.JVcGyCEIKi/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.q8bkt4qvys/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 17:32: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:32: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 jsonschema==2.5.1 17:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JVcGyCEIKi/Render', 17:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:32:24 INFO - 'HOME': '/Users/cltbld', 17:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:32:24 INFO - 'LOGNAME': 'cltbld', 17:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:24 INFO - 'MOZ_NO_REMOTE': '1', 17:32:24 INFO - 'NO_EM_RESTART': '1', 17:32:24 INFO - 'PAGER': '/bin/cat', 17:32:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:24 INFO - 'PWD': '/builds/slave/test', 17:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:32:24 INFO - 'SHELL': '/bin/bash', 17:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q8bkt4qvys/Listeners', 17:32:24 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 17:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:32:24 INFO - 'USER': 'cltbld', 17:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:24 INFO - 'XPC_FLAGS': '0x0', 17:32:24 INFO - 'XPC_SERVICE_NAME': '0', 17:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:24 INFO - Downloading/unpacking jsonschema==2.5.1 17:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:32:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:32:27 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 17:32:27 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 17:32:27 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 17:32:27 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 17:32:27 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 17:32:27 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 17:32:27 INFO - Downloading functools32-3.2.3-2.tar.gz 17:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:32:27 INFO - warning: no files found matching '*.txt' 17:32:27 INFO - no previously-included directories found matching 'build' 17:32:27 INFO - no previously-included directories found matching 'dist' 17:32:27 INFO - no previously-included directories found matching '.git*' 17:32:27 INFO - Installing collected packages: jsonschema, functools32 17:32:27 INFO - Running setup.py install for functools32 17:32:27 INFO - warning: no files found matching '*.txt' 17:32:27 INFO - no previously-included directories found matching 'build' 17:32:27 INFO - no previously-included directories found matching 'dist' 17:32:27 INFO - no previously-included directories found matching '.git*' 17:32:27 INFO - Successfully installed jsonschema functools32 17:32:27 INFO - Cleaning up... 17:32:27 INFO - Return code: 0 17:32:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:28 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')]} 17:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:28 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 0x109d6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefea4afe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ad30>, '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 0x109a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b3fbe8>, '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.JVcGyCEIKi/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.q8bkt4qvys/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 17:32:28 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 17:32:28 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 17:32:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JVcGyCEIKi/Render', 17:32:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:32:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:32:28 INFO - 'HOME': '/Users/cltbld', 17:32:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:32:28 INFO - 'LOGNAME': 'cltbld', 17:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:28 INFO - 'MOZ_NO_REMOTE': '1', 17:32:28 INFO - 'NO_EM_RESTART': '1', 17:32:28 INFO - 'PAGER': '/bin/cat', 17:32:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:28 INFO - 'PWD': '/builds/slave/test', 17:32:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:32:28 INFO - 'SHELL': '/bin/bash', 17:32:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q8bkt4qvys/Listeners', 17:32:28 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 17:32:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:32:28 INFO - 'USER': 'cltbld', 17:32:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:32:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:28 INFO - 'XPC_FLAGS': '0x0', 17:32:28 INFO - 'XPC_SERVICE_NAME': '0', 17:32:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:32:28 INFO - Cleaning up... 17:32:28 INFO - Return code: 0 17:32:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:32:28 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')]} 17:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:28 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')]} 17:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32: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', '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 0x109d6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefea4afe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ad30>, '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 0x109a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b3fbe8>, '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.JVcGyCEIKi/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.q8bkt4qvys/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 17:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:32: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 blobuploader==1.2.4 17:32:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JVcGyCEIKi/Render', 17:32:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:32:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:32:29 INFO - 'HOME': '/Users/cltbld', 17:32:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:32:29 INFO - 'LOGNAME': 'cltbld', 17:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:29 INFO - 'MOZ_NO_REMOTE': '1', 17:32:29 INFO - 'NO_EM_RESTART': '1', 17:32:29 INFO - 'PAGER': '/bin/cat', 17:32:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:29 INFO - 'PWD': '/builds/slave/test', 17:32:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:32:29 INFO - 'SHELL': '/bin/bash', 17:32:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q8bkt4qvys/Listeners', 17:32:29 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 17:32:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:32:29 INFO - 'USER': 'cltbld', 17:32:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:32:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:29 INFO - 'XPC_FLAGS': '0x0', 17:32:29 INFO - 'XPC_SERVICE_NAME': '0', 17:32:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:29 INFO - Downloading/unpacking blobuploader==1.2.4 17:32:29 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 17:32:29 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 17:32:29 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 17:32:29 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 17:32:29 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 17:32:29 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 17:32:32 INFO - Downloading blobuploader-1.2.4.tar.gz 17:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:32:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:32:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:32: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 17:32: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 17:32: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 17:32: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 17:32: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 17:32: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 17:32:33 INFO - Downloading docopt-0.6.1.tar.gz 17:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:32:33 INFO - Installing collected packages: blobuploader, requests, docopt 17:32:33 INFO - Running setup.py install for blobuploader 17:32:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:32:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:32:34 INFO - Running setup.py install for requests 17:32:34 INFO - Running setup.py install for docopt 17:32:34 INFO - Successfully installed blobuploader requests docopt 17:32:34 INFO - Cleaning up... 17:32:34 INFO - Return code: 0 17:32:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:34 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')]} 17:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:34 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')]} 17:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:34 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 0x109d6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefea4afe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ad30>, '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 0x109a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b3fbe8>, '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.JVcGyCEIKi/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.q8bkt4qvys/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 17:32:34 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 17:32:34 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 17:32:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JVcGyCEIKi/Render', 17:32:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:32:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:32:34 INFO - 'HOME': '/Users/cltbld', 17:32:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:32:34 INFO - 'LOGNAME': 'cltbld', 17:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:34 INFO - 'MOZ_NO_REMOTE': '1', 17:32:34 INFO - 'NO_EM_RESTART': '1', 17:32:34 INFO - 'PAGER': '/bin/cat', 17:32:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:34 INFO - 'PWD': '/builds/slave/test', 17:32:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:32:34 INFO - 'SHELL': '/bin/bash', 17:32:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q8bkt4qvys/Listeners', 17:32:34 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 17:32:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:32:34 INFO - 'USER': 'cltbld', 17:32:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:32:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:34 INFO - 'XPC_FLAGS': '0x0', 17:32:34 INFO - 'XPC_SERVICE_NAME': '0', 17:32:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:32:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-xIftFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:32:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-J5BS5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:32:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-kaHnTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:32:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-u9IdnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:32:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-p7__WG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:32:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ZPQAL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:32:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-LgYTZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:32:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-gY5lub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:32:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-03unUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:32:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Gvej2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:32:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-_pD1I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:32:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-xZ_JZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:32:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-LxuZkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:32:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-A7J6_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-JQovUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:32:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-MJ2JW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:32:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9EjxYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:32:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:32:36 INFO - Running setup.py install for manifestparser 17:32:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Running setup.py install for mozcrash 17:32:37 INFO - Running setup.py install for mozdebug 17:32:37 INFO - Running setup.py install for mozdevice 17:32:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:32:37 INFO - Running setup.py install for mozfile 17:32:37 INFO - Running setup.py install for mozhttpd 17:32:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:32:37 INFO - Running setup.py install for mozinfo 17:32:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:32:37 INFO - Running setup.py install for mozInstall 17:32:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:32:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:32:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:32:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:32:37 INFO - Running setup.py install for mozleak 17:32:38 INFO - Running setup.py install for mozlog 17:32:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:32:38 INFO - Running setup.py install for moznetwork 17:32:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:32:38 INFO - Running setup.py install for mozprocess 17:32:38 INFO - Running setup.py install for mozprofile 17:32:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:32:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:32:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:32:38 INFO - Running setup.py install for mozrunner 17:32:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:32:38 INFO - Running setup.py install for mozscreenshot 17:32:39 INFO - Running setup.py install for moztest 17:32:39 INFO - Running setup.py install for mozversion 17:32:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:32:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:32:39 INFO - Cleaning up... 17:32:39 INFO - Return code: 0 17:32:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:39 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 0x109d6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefea4afe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ad30>, '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 0x109a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b3fbe8>, '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.JVcGyCEIKi/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.q8bkt4qvys/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 17:32:39 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 17:32:39 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 17:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JVcGyCEIKi/Render', 17:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:32:39 INFO - 'HOME': '/Users/cltbld', 17:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:32:39 INFO - 'LOGNAME': 'cltbld', 17:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:39 INFO - 'MOZ_NO_REMOTE': '1', 17:32:39 INFO - 'NO_EM_RESTART': '1', 17:32:39 INFO - 'PAGER': '/bin/cat', 17:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:39 INFO - 'PWD': '/builds/slave/test', 17:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:32:39 INFO - 'SHELL': '/bin/bash', 17:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q8bkt4qvys/Listeners', 17:32:39 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 17:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:32:39 INFO - 'USER': 'cltbld', 17:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:39 INFO - 'XPC_FLAGS': '0x0', 17:32:39 INFO - 'XPC_SERVICE_NAME': '0', 17:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:32:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-jSq5zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:32:39 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)) 17:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:32:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ehoXot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:32:39 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)) 17:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:32:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-blSPvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:32:40 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)) 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:32:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-h5SMuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:32:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-AeXCFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:32:40 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)) 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:32:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Gz2OIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:32:40 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)) 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:32:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-CQeYwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:32:40 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)) 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:32:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-RtohTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:32:40 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)) 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:32:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-kNXToz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:32:40 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)) 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:32:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-uKUy1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:32:40 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)) 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:32:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-dhejnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:32:40 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)) 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:32:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-jzy49u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:32:40 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)) 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:32:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-lVeaSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:32:41 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)) 17:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:32:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-8SASdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:32:41 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)) 17:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-2Q7Q0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:41 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)) 17:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:32:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-UAvkwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:32:41 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)) 17:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:32:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-5m0cU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:32:41 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)) 17:32:41 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)) 17:32:41 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)) 17:32:41 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)) 17:32:41 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:32:41 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:32:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:32: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 17:32: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 17:32: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 17:32: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 17:32: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 17:32: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 17:32:44 INFO - Downloading blessings-1.6.tar.gz 17:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:32:44 INFO - Installing collected packages: blessings 17:32:44 INFO - Running setup.py install for blessings 17:32:44 INFO - Successfully installed blessings 17:32:44 INFO - Cleaning up... 17:32:44 INFO - Return code: 0 17:32:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:32:44 INFO - Reading from file tmpfile_stdout 17:32:44 INFO - Current package versions: 17:32:44 INFO - blessings == 1.6 17:32:44 INFO - blobuploader == 1.2.4 17:32:44 INFO - docopt == 0.6.1 17:32:44 INFO - functools32 == 3.2.3-2 17:32:44 INFO - jsonschema == 2.5.1 17:32:44 INFO - manifestparser == 1.1 17:32:44 INFO - mozInstall == 1.12 17:32:44 INFO - mozcrash == 1.0 17:32:44 INFO - mozdebug == 0.1 17:32:44 INFO - mozdevice == 0.50 17:32:44 INFO - mozfile == 1.2 17:32:44 INFO - mozhttpd == 0.7 17:32:44 INFO - mozinfo == 0.9 17:32:44 INFO - mozleak == 0.1 17:32:44 INFO - mozlog == 3.4 17:32:44 INFO - moznetwork == 0.27 17:32:44 INFO - mozprocess == 0.25 17:32:44 INFO - mozprofile == 0.28 17:32:44 INFO - mozrunner == 6.13 17:32:44 INFO - mozscreenshot == 0.1 17:32:44 INFO - mozsystemmonitor == 0.3 17:32:44 INFO - moztest == 0.8 17:32:44 INFO - mozversion == 1.4 17:32:44 INFO - psutil == 3.1.1 17:32:44 INFO - requests == 1.2.3 17:32:44 INFO - wsgiref == 0.1.2 17:32:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:44 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')]} 17:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:44 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')]} 17:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:44 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 0x109d6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefea4afe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ad30>, '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 0x109a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b3fbe8>, '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.JVcGyCEIKi/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.q8bkt4qvys/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 17:32:44 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 17:32:44 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 17:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JVcGyCEIKi/Render', 17:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:32:44 INFO - 'HOME': '/Users/cltbld', 17:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:32:44 INFO - 'LOGNAME': 'cltbld', 17:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:44 INFO - 'MOZ_NO_REMOTE': '1', 17:32:44 INFO - 'NO_EM_RESTART': '1', 17:32:44 INFO - 'PAGER': '/bin/cat', 17:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:44 INFO - 'PWD': '/builds/slave/test', 17:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:32:44 INFO - 'SHELL': '/bin/bash', 17:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q8bkt4qvys/Listeners', 17:32:44 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 17:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:32:44 INFO - 'USER': 'cltbld', 17:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:44 INFO - 'XPC_FLAGS': '0x0', 17:32:44 INFO - 'XPC_SERVICE_NAME': '0', 17:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:44 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)) 17:32:44 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)) 17:32:44 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)) 17:32:44 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)) 17:32:44 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)) 17:32:44 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)) 17:32:44 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)) 17:32:44 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)) 17:32:44 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)) 17:32:44 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)) 17:32:44 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)) 17:32:44 INFO - Cleaning up... 17:32:45 INFO - Return code: 0 17:32:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:45 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 0x109d6cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d6f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefea4afe60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ad30>, '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 0x109a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b3fbe8>, '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.JVcGyCEIKi/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.q8bkt4qvys/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 17:32:45 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 17:32:45 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 17:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JVcGyCEIKi/Render', 17:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:32:45 INFO - 'HOME': '/Users/cltbld', 17:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:32:45 INFO - 'LOGNAME': 'cltbld', 17:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:45 INFO - 'MOZ_NO_REMOTE': '1', 17:32:45 INFO - 'NO_EM_RESTART': '1', 17:32:45 INFO - 'PAGER': '/bin/cat', 17:32:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:45 INFO - 'PWD': '/builds/slave/test', 17:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:32:45 INFO - 'SHELL': '/bin/bash', 17:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q8bkt4qvys/Listeners', 17:32:45 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 17:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:32:45 INFO - 'USER': 'cltbld', 17:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:45 INFO - 'XPC_FLAGS': '0x0', 17:32:45 INFO - 'XPC_SERVICE_NAME': '0', 17:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:32:45 INFO - Cleaning up... 17:32:45 INFO - Return code: 0 17:32:45 INFO - Running post-action listener: _resource_record_post_action 17:32:45 INFO - Running post-action listener: _start_resource_monitoring 17:32:45 INFO - Starting resource monitoring. 17:32:45 INFO - [mozharness: 2017-04-29 00:32:45.309147Z] Finished create-virtualenv step (success) 17:32:45 INFO - [mozharness: 2017-04-29 00:32:45.310173Z] Running install step. 17:32:45 INFO - Running pre-action listener: _resource_record_pre_action 17:32:45 INFO - Running main action method: install 17:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:32:45 INFO - Reading from file tmpfile_stdout 17:32:45 INFO - Detecting whether we're running mozinstall >=1.0... 17:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:32:45 INFO - Reading from file tmpfile_stdout 17:32:45 INFO - Output received: 17:32:45 INFO - Usage: mozinstall [options] installer 17:32:45 INFO - Options: 17:32:45 INFO - -h, --help show this help message and exit 17:32:45 INFO - -d DEST, --destination=DEST 17:32:45 INFO - Directory to install application into. [default: 17:32:45 INFO - "/builds/slave/test"] 17:32:45 INFO - --app=APP Application being installed. [default: firefox] 17:32:45 INFO - mkdir: /builds/slave/test/build/application 17:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:33:05 INFO - Reading from file tmpfile_stdout 17:33:05 INFO - Output received: 17:33:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:33:05 INFO - Running post-action listener: _resource_record_post_action 17:33:05 INFO - [mozharness: 2017-04-29 00:33:05.177969Z] Finished install step (success) 17:33:05 INFO - [mozharness: 2017-04-29 00:33:05.178120Z] Running run-tests step. 17:33:05 INFO - Running pre-action listener: _resource_record_pre_action 17:33:05 INFO - Running main action method: run_tests 17:33:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:33:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:33:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:33:05 INFO - 2017-04-28 17:33:05.193 screenresolution[1897:18001] starting screenresolution argv=screenresolution get 17:33:05 INFO - 2017-04-28 17:33:05.195 screenresolution[1897:18001] Display 0: 1600x1200x32@60 17:33:05 INFO - 2017-04-28 17:33:05.201 screenresolution[1898:18004] starting screenresolution argv=screenresolution list 17:33:05 INFO - Available Modes on Display 0 17:33:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:33:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:33:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:33:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:33:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:33:05 INFO - Intel Iris: 17:33:05 INFO - Chipset Model: Intel Iris 17:33:05 INFO - Type: GPU 17:33:05 INFO - Bus: Built-In 17:33:05 INFO - VRAM (Dynamic, Max): 1536 MB 17:33:05 INFO - Vendor: Intel (0x8086) 17:33:05 INFO - Device ID: 0x0a2e 17:33:05 INFO - Revision ID: 0x0009 17:33:05 INFO - Displays: 17:33:05 INFO - Display: 17:33:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:33:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:33:05 INFO - Display Serial Number: 1600x1200 60 17:33:05 INFO - Main Display: Yes 17:33:05 INFO - Mirror: Off 17:33:05 INFO - Online: Yes 17:33:05 INFO - Rotation: Supported 17:33:05 INFO - Return code: 0 17:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:33:05 INFO - Python 2.7.3 17:33:05 INFO - Return code: 0 17:33:05 INFO - grabbing minidump binary from tooltool 17:33:05 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')]} 17:33:05 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 0x109b4ad30>, '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 0x109a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b3fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:33:05 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 17:33:05 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 17:33:05 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 17:33:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:33:05 INFO - Return code: 0 17:33:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:33:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:33:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:33:05 INFO - ENV: RUST_BACKTRACE is now 1 17:33:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:33:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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 17:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --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 17:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JVcGyCEIKi/Render', 17:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:05 INFO - 'HOME': '/Users/cltbld', 17:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:05 INFO - 'LOGNAME': 'cltbld', 17:33:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:33:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:05 INFO - 'MOZ_NO_REMOTE': '1', 17:33:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:33:05 INFO - 'NO_EM_RESTART': '1', 17:33:05 INFO - 'PAGER': '/bin/cat', 17:33:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:05 INFO - 'PWD': '/builds/slave/test', 17:33:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:05 INFO - 'RUST_BACKTRACE': '1', 17:33:05 INFO - 'SHELL': '/bin/bash', 17:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q8bkt4qvys/Listeners', 17:33:05 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 17:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:05 INFO - 'USER': 'cltbld', 17:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:05 INFO - 'XPC_FLAGS': '0x0', 17:33:05 INFO - 'XPC_SERVICE_NAME': '0', 17:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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 17:33:05 INFO - mozversion application_buildid: 20170428075320 17:33:05 INFO - mozversion application_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:33:05 INFO - mozversion application_display_name: Nightly 17:33:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:33:05 INFO - mozversion application_name: Firefox 17:33:05 INFO - mozversion application_remotingname: firefox 17:33:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:33:05 INFO - mozversion application_vendor: Mozilla 17:33:05 INFO - mozversion application_version: 55.0a1 17:33:05 INFO - mozversion platform_buildid: 20170428075320 17:33:05 INFO - mozversion platform_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:33:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:33:05 INFO - mozversion platform_version: 55.0a1 17:33:05 INFO - using testdate: 1493425985 17:33:05 INFO - actual date: 1493425985 17:33:05 INFO - starting webserver on 'localhost:56919' 17:33:05 INFO - SUITE-START | Running 2 tests 17:33:05 INFO - TEST-START | dromaeo_css 17:33:05 INFO - operating with platform_type : mac_ 17:33:05 INFO - Initialising browser for dromaeo_css test... 17:33:05 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpyxf937/profile http://localhost:56919/getInfo.html) 17:33:08 INFO - PID 1908 | __metrics Screen width/height:1600/1200 17:33:08 INFO - PID 1908 | colorDepth:24 17:33:08 INFO - PID 1908 | Browser inner width/height: 1024/689 17:33:08 INFO - PID 1908 | __metrics 17:33:08 INFO - PID 1908 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:33:08 INFO - PID 1908 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:33:09 INFO - TEST-INFO | 1908: exit 0 17:33:09 INFO - Browser initialized. 17:33:09 INFO - Running cycle 1/1 for dromaeo_css test... 17:33:09 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpyxf937/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:33:21 INFO - PID 1909 | RSS: Main: 242417664 17:33:21 INFO - PID 1909 | 17:36:25 INFO - PID 1909 | Cycle 1(1): loaded http://localhost:56919/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56919/tests/dromaeo/cssquery-ext.html) 17:36:28 INFO - PID 1909 | RSS: Main: 381980672 17:36:28 INFO - PID 1909 | 17:38:10 INFO - PID 1909 | ************************* 17:38:10 INFO - PID 1909 | A coding exception was thrown and uncaught in a Task. 17:38:10 INFO - PID 1909 | 17:38:10 ERROR - PID 1909 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:38:10 INFO - PID 1909 | Full stack: 17:38:10 INFO - PID 1909 | ************************* 17:38:10 INFO - PID 1909 | ************************* 17:38:10 INFO - PID 1909 | A coding exception was thrown and uncaught in a Task. 17:38:10 INFO - PID 1909 | 17:38:10 ERROR - PID 1909 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:38:10 INFO - PID 1909 | Full stack: 17:38:10 INFO - PID 1909 | ************************* 17:38:10 INFO - PID 1909 | ************************* 17:38:10 INFO - PID 1909 | A coding exception was thrown and uncaught in a Task. 17:38:10 INFO - PID 1909 | 17:38:10 ERROR - PID 1909 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:38:10 INFO - PID 1909 | Full stack: 17:38:10 INFO - PID 1909 | ************************* 17:38:10 INFO - PID 1909 | ************************* 17:38:10 INFO - PID 1909 | A coding exception was thrown and uncaught in a Task. 17:38:10 INFO - PID 1909 | 17:38:10 ERROR - PID 1909 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:38:10 INFO - PID 1909 | Full stack: 17:38:10 INFO - PID 1909 | ************************* 17:39:30 INFO - PID 1909 | Cycle 1(1): loaded http://localhost:56919/tests/dromaeo/cssquery-ext.html (next: http://localhost:56919/tests/dromaeo/cssquery-jquery.html) 17:39:31 INFO - PID 1909 | RSS: Main: 368091136 17:39:31 INFO - PID 1909 | 17:42:33 INFO - PID 1909 | Cycle 1(1): loaded http://localhost:56919/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56919/tests/dromaeo/cssquery-mootools.html) 17:42:34 INFO - PID 1909 | RSS: Main: 357617664 17:42:34 INFO - PID 1909 | 17:45:36 INFO - PID 1909 | Cycle 1(1): loaded http://localhost:56919/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56919/tests/dromaeo/cssquery-prototype.html) 17:45:37 INFO - PID 1909 | RSS: Main: 339333120 17:45:37 INFO - PID 1909 | 17:48:40 INFO - PID 1909 | Cycle 1(1): loaded http://localhost:56919/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56919/tests/dromaeo/cssquery-yui.html) 17:48:41 INFO - PID 1909 | RSS: Main: 338251776 17:48:41 INFO - PID 1909 | 17:51:43 INFO - PID 1909 | Cycle 1(1): loaded http://localhost:56919/tests/dromaeo/cssquery-yui.html (next: http://localhost:56919/tests/dromaeo/cssquery-dojo.html) 17:51:44 INFO - PID 1909 | RSS: Main: 377565184 17:51:44 INFO - PID 1909 | 17:51:44 INFO - PID 1909 | __start_tp_report 17:51:44 INFO - PID 1909 | _x_x_mozilla_page_load 17:51:44 INFO - PID 1909 | _x_x_mozilla_page_load_details 17:51:44 INFO - PID 1909 | |i|pagename|runs| 17:51:44 INFO - PID 1909 | |0;dojo.html;3429.8971030869084;3432.897013089608;3451.8619255229787;3484.0070579884737;3504.071421073416;5868.207791948085;6000;6055.757769689213;6079.9999999999945;6108.786192483264;5858.3596592954045;5933.525317974551;5943.702814859262;5949.49429298509;5955.612885162462;5185.092608793456;5211.114110601206;5213.426523082458;5215.582753379739;5228.947710522884;5320.866978325554;5323.494268044549;5328.813491527797;5331.067063263933;5342.98483288176;5316.20256961455;5316.893662126755;5336.332958380202;5338.652987555816;5339;5313.1764576490705;5322.627416080876;5327.520523152934;5333.546648534879;5345.412004679482;5120.6927584344685;5228.215767634847;5253.212018197263;5275.920861187085;5306.628536002481;6062.818115456544;6089;6092.939070609282;6137.877242455171;6144.723487443076;6390.6485143317095;6393.168888044571;6416.775412860574;6428.4214420702365;6455.257645370749;4882.731449770261;6254.874902501924;6329.240491141047;6463.515236357292;6482.805515834532;6171.290301615327;6174.938250617436;6181.474574661159;6183.505319574513;6187.938120618781;6631.602103873783;6631.801045968628;6638.4689224861895;6643.60138391698;6662.067310576524;6210.31686514483;6293.2762732285455;6302.1492098566105;6305.96847015762;6343.270523889812;6378.968105159444;6399.584027038228;6437.645929473831;6438.484921206292;6451.741930322828;6335.904961425582;6338.619682819046;6347.619142851444;6354.332795056545;6356.332585078592;6251.562390632703;6274.466670333073;6282.340354262737;6337.873242535124;6368.554201205964;5038.370203724535;5137.717425541631;5161.948380516222;5242.397124330674;5251.133562962068;4557.316402539579;4558.840440584564;4576.0161565263625;4629.814807407666;4638.930416043762;6102.389761023862;6138.281281241259;6147.44672979434;6150.7232174552255;6166.920788861931;6384.48924086072;6456.031595260654;6457.5479716419395;6462.644554549451;6468.320826313169;5956.493698035715;6054.3945605439985;6060.484858786965;6143.938560614426;6218.5647004709235;5677.77288908439;5726.942730572641;5739.282589676291;5745.023346031185;5746.0519014363;6644.036614690843;6656.866862662817;6669.6665166740495;6673.833154171185;6673.8998915015345;6397.840053998687;6418.967905160444;6443.67781610927;6478.125453063776;6489.091527186292;6422.743090276336;6518.934810651833;6527.771527996498;6529.771457998947;6669.699863506057;6327.588706734047;6328.493720502257;6337.207849018872;6343.777967771106;6347.143135676809;4494.977525112354;6300.243970723359;6404.93595064062;6450.516211284079;6468.902966455601;6311.463525600376;6328.0507923809955;6331.96834015827;6345.206849143857;6348.809535713936;5707.400722924033;6328.936710632835;6341.460975816923;6349.238091429058;6371.55399122057;6078.969605151946;6119.015143218386;6125.235451818428;6282.528810339151;6287.685615719104;6259.436650701458;6302.779402720883;6320.178376810985;6322.841928951813;6327.620342779448;6215.627062376272;6233.158523599256;6240.656763878031;6250.156228909039;6257 17:51:44 INFO - PID 1909 | |1;ext.html;781.2734157233772;1108.074757577423;1126.1385040444056;1128.2271643923918;1225.6261840138754;36688.63311366885;37910.620893791056;37942.8102859486;37961.62038379615;38021.619783802154;37483.68807091746;37765.244695106085;37855.24289514208;37926.0518487038;37929.620703792956;5931.703414829263;6033.577649564532;7814.452988290807;7955.363570914313;7960.562169080698;6022.397760223965;6109.816705498843;6111.449969502743;6565.737370505174;8490.490570565786;8535.701250456235;8573.957130214372;8578.828423431527;8582.399232053758;8620.008698999633;8473.406861519665;8532.488050716976;8547.572621368938;8559.101294364064;8565.314774818;5933.436323549256;6043.214382130295;6048.788292409745;6049.334573196945;8310.70912518059;21531.56936861254;35667.82166089153;35773.82113089444;35893.64106358929;35902.10244743876;3589.8564057437934;3619.2037751694584;3625.583057948343;3626.601073881871;3631.673149416565;30445.086647400614;30575;30578.69421305803;30581.235469113228;30620.54069188964;2961.2448825549563;3145.1665308693214;3160.0993716790604;3162.2252548125625;3199.376121656278;281580;285666;287087;287896.5605171982;289722;39817.80546583607;39866.80066599706;40119;48876.511234887905;49104.77238069077;49333;49530.504694952586;49641.05025296461;49662.75168624134;50044.249336259985;13702.588922332347;13787.241701706502;13793.10344827583;13803.309834508234;13805.585832425044;11220.887791122148;11222.66332010041;11226.326420414802;11228.775424491629;11246.156538259664;12713.682157946125;12716.554920577735;12729.809052864215;12787.808182877265;12829.166104203197;5460.754266058037;5479.808206712746;5484.533814625722;5489.204065410493;5502.697351645698;843.9535825529655;980.1570649241646;991.4002028772488;1011.3577878047493;1018.5212949913529;23212;24138;30653.23366915845;31024.379512409625;31383.686163138533;970.1026550440955;995.1789773436943;1103.690966529373;1114.2812885688686;1143.7083543696472;12523.499060037497;12698.301698301699;12840.908522775482;12847.164934279243;12881.484740610458;310369;335217;335534;335646;335791;48356.75821620869;56051.878962420524;56234;56412.717936410874;56490;1526.8167819861687;1533.555268972008;1575.298991948595;1581.7311057120316;1592.2834724373847;24589.639522562415;29973.801047957837;30249.395012099194;30672.693273066983;30675.386492270474;54192.72903635457;54651.63370915759;54703;54719;54723.72638136784;311915;313767;313871;314013;314955;35922.10194745048;36747.816260918524;37206;37292.81353593323;37316.813415932746;44761.776191118835;45671.31493027541;46413.535864642276;47038.294425584325;47149.528504714515;30380.24049398783;31141.377172456876;31815.840920795246;31876.884309049074;32267.193320167185;30979.970572644914;31415.528767068055;31684.36631267408;31848.52227216547;31892.564834582034;38284;38398.54413102834;38462.807685961394;38526.80736596299;38533.42199866948;24511.142110026063;28461.592297463416;30417;31744.682553174174;32166.67833321637;22981.77018229796;24787;24869;24986.823393696934;24999.87500062488 17:51:44 INFO - PID 1909 | |2;jquery.html;385.09886864736546;424.16982502994716;432.63226257680975;444.85097492340066;448.394667199281;16936;21107.894460527714;21506.709597424164;22249;22547.887260563715;22434.663480047813;22738.521996070285;23183.420414489647;23205.883970580122;23286.41783955402;4861.857463496076;6043.969780151093;6237.313895471494;6273.937260627404;6299.1496148020115;6096.695165241742;6212.068189771525;6212.565120441571;6213.66406222662;6216.347283535231;6025.517958563326;6072.08918662202;6114.957622060394;6149.631022138686;6199.659018753967;5061.822836200715;5628.817948230856;5735.655860648353;6054.424829641177;6164.3835616438;5237.423883372826;5474.91787623186;5486.31421072366;5487.807926722546;5489.560835133179;26563.203103906915;26612.600810987657;26664.466710665678;26713.866430667917;26746.598801018;2253.425376528991;2299.528596637685;2299.8735069571167;2300.1374484568287;2303.1478353009493;17421.738673919903;17815.910920445443;18029.819701803077;18037.458876233602;18051.9240287366;1769.761082253905;2102.5479521902867;2164.9865624968775;2172.250573552122;2181.345596321097;149654;150146;150922;151192.48807511895;154187;9680.128788408936;10163.441010744333;11375.601853935073;11881.168318217815;12557.309347985949;13511.729765404834;15378.231088445533;16244.675106497803;16798;16872.240749166318;8821.38250322484;8864.601092950703;8931.330150238759;9047.185753282236;9113.225375842994;8469.153084691605;8496.66013359471;8503.447275927168;8674.696385626472;8682.565871706389;6410.423061924449;7685.308322250912;7803.843923121619;7841.5687137208;7845.843083138419;1843.8340549350355;2183.159483598794;2205.22817014047;2206.0734491513604;2221.922232721847;824.7360844529812;956.9473678947586;963.450833025183;975.7560609847538;1009.485162567096;21210.787892120883;21897.671534926987;22076.448088797908;25673;27768.861155694496;982.3860087445347;987.9950600246952;997.3941953454931;1016.5476363018533;1023.6110278094277;10931.672049838518;11294.378809165575;11382.886171138183;11443.885561144281;11486.59796907121;449703;560266;567430;578323;580754;135458;136074;138711;141965;143487.5651243495;1168.707823044239;1211.4911737070452;1221.1635030004297;1222.376587940157;1231.4150778380376;18568.814311857248;18908.810911890705;18967.146478408227;18982.620347592696;19165.041747912826;51183;52270;53056.73471632617;54229.72885135549;54813.451865480834;64273.67863160841;68940;69773.95339069817;71022.28977710157;71195.64402177956;8921.464712117293;8942.552872356486;9071.319651026331;9128.041555636562;9164.495952722664;14329.78505322442;14427.116073477731;14638.048526845721;14782.260886955393;14853.85146148568;11357.204995650556;11446.02708769764;11705.707357316136;11934.462949167135;12264.75470490603;10009.449480278654;10175.084242418217;10977.121830253402;11188;11441.885581144083;11801.82297265559;12158.02735781153;12516.557946564768;12531.498740050296;12631.494740210288;8837.381383303107;9027.45835249887;9114.225290850352;9155.26757859383;9355.391899526508;9953.253505986935;11029.61396351124;11948.46231919583;11971.580994665144;12290.139690221598 17:51:44 INFO - PID 1909 | |3;mootools.html;1195.4739914437646;1443.285573641048;1460.656745664769;1463.187930698462;1471.4114354258302;11054.889451105486;11589.014933730632;11589.884101158987;11592.59425920093;11616.186866919319;10488.37069775814;11509.539618415254;11652.825207621892;11663.008644265248;11668.941655291734;2495.5882279423918;2542.5931850903858;2543.78377837884;2545.2109845947816;2546.248856587302;2045.1410407628832;2363.3382652857226;2501.6372625969225;2502.674652295199;2506.586413241822;2124.2034237161065;2226.1985685153413;2521.760432758885;2523.671922650053;2523.83595066321;2472.9134480293283;2480.8263421560496;2496.6005439129835;2498.287987923451;2500.1499490173337;2485.030837973192;2485.378655336166;2489.8630575318352;2489.8755062246814;2494.77547020769;11447;11452.541898324058;11598.826017609743;11600.30398176112;11619.302841829518;6475.352464753534;6734.56225345351;6739.5282330236905;6743.35938085881;6744.325567443217;3319.3195394943978;4099.098198396348;4240.342746874239;4246.787660616957;4258.127083947814;1240.4232032105115;1241.416534228911;1264.4310060472824;1269.581038257373;1279.62890761679;16210.675786484204;16349.918250408791;16360.345586176538;16365.34538618454;16368.83631163697;5274.709890955957;5315.707636079976;5461.617686761889;5562.221289019541;5590.2453168821685;11626.302421854716;11629.47667354971;11632.360220187802;11633;11664.94167529157;6500.3174666659315;6501.837454063591;6505.056766768792;6513.869722605521;6522.543421960418;4561.657875659339;6169.537284703665;6186.948218802814;6212.285587157535;6247.843803904939;3637.018005138598;4119.258533463945;4285.5928686774705;4300.0969796343115;4342;1263.1158189267367;1265.9810102848464;1282.9679258018436;1284.466946217328;1291.7674818532566;668.6155460610169;701.8701540215077;788.5978151142958;798.4450806689412;807.0799288810761;6719.563228390139;6780.1524809398825;6843.281455447206;7016.403605693573;7035.6482175891;569.2855466389655;608.975640974365;611.9510439164945;612.8161551534522;710.2719712294939;3983.8605648802154;4470.619997300201;4484.887877803081;4534.2745160774775;4717.976410117927;14577.489787857374;15148.318325675371;15156.772648410282;15202.011869228465;15280.006799557994;14406.927965360106;14819.925900370645;14950.925245373703;14957.476488322856;15032.473863414729;8258.958705206436;8474.618642161118;8517.276031537265;8521.977362716514;8556;6039.701464185221;6956.530431696675;6986.336298051677;7017.754378596725;7069.187043489859;13085.803712944504;13602.86397136016;13610.523631672844;13908.721825563634;13924.721505570034;13312.201267923956;13575.456981720621;14082.929585352007;14112.88306753954;14144.575662730134;9028.954855225682;9258.72223833286;9421.528923553658;9422.95288523553;9429.198518126037;9856.655017074369;10000.949995249977;10008.499575021075;10012.19902407791;10022.899771002489;8199.385046121684;9001.504917229615;9074.682386116454;9085.046070162538;9109.498977556297;8734.126587341216;8848.690295839615;8861.822763544822;8935.731928042169;8956.28349732033;8160.183981601793;8180.345572354078;8264.462809917337;8271.627776750182;8293.087760346236;5963.4334738199805;6000.789972350947;6124.8775024500155;6135.815925522242;6215.81352559424;5661.179129026185;6008.459238668541;6027.457528822427;6164.753409863734;6269.968650156902 17:51:44 INFO - PID 1909 | |4;prototype.html;384.1414438729439;387.13282247765017;396.88887111608744;407.9469668943038;408.397613520058;5622.526088521058;5798.507126894219;5878.0609695152425;5922.407759224076;5993.190919225904;5558.416366281543;5636.2954630671165;5751.884962300752;5792.420757924216;5814.651120932747;4381.211381951255;4494.460664720238;4496.505384407713;4500.324951257321;4507.166174257756;3920.901977450558;4139.006638406776;4477.6417886569;4485.820567177309;4488.655951316274;3906.980465097685;4407.382966384709;4432.11357728454;4446.488653804805;4463.352813841991;3597.244578638489;3672.577653569847;3983.900402489932;4075.53131389891;4450.465944086698;3242.4649932761067;3893.7469064510715;3961.524617045944;3985.561588225293;4004.6395824375945;5630.479770461993;5640.943590564083;5653.660780353151;5674.546036317085;5715.028055501428;4418.889527761799;4526.615237704799;5256.001359741636;5272.499112584298;5347.732613369316;5577.776888924438;5943.494802941756;6167.982282923313;6188.783392581238;6212.695333979869;4498.977505112486;4545.250033744428;4545.909081818379;4548.681592288541;4553.362529245908;5961.821145365646;6186.958303759749;6491.67541622917;6514.283428822826;6540.313267106981;3661.029827095822;4016.9397459038137;4101.938470922939;4161.417401563784;4166.479190101238;3526.3476256892045;3536.840842162109;4226.725262857966;4235.1317979814685;4255;4819.156647586658;4959.0329885671945;4976.502349765067;4977.552020318189;4997.775100120503;5243;5858.677772722541;6166.290876549165;6181.96909015452;6233.254688687175;1279.4818098670053;1366.2075995922341;1383.2046573220236;1402.3128666953323;1430.1919415530192;764.2472164917551;819.4059307002376;895.4761464543316;932.4009324009221;939.4128669581512;5170.087067784869;5846.853828654318;5893.233879595711;5903.527717782567;5907.438793314628;5399.622026458111;6307.590006649553;6319.46284565817;6330.588511746721;6357.96821015892;5597.776088956396;5722.7982123753645;5812.505936995318;5860.7436137087525;5870.354261031283;2850.800443968944;3041;3073.800202986799;3214.517822326623;3331.617893206321;5460.726963651881;5545.805896793593;6404.679766011774;6452.5805822622315;6582.80251592453;5670.773169073191;6503.447206987459;6525.347465253437;6525.869482610321;6530.09410812184;6372.58578192416;6533.490246140389;6557.180352455943;6566.967165164144;6611.966940165268;5034.672746271481;5593.384727680033;6053.697315134314;6302.558820882494;6373.649449280334;6282.057691346335;6290.836195303884;6303.590266632654;6308.968455157878;6312.3056463788025;5541.445855414588;5829.067349224104;6245.125682404376;6616.974368972625;6708;3974.4237085623;4160.791960401907;4165.1461450401985;4179.059711564995;4190.476190476191;6179.258488981351;6271.78048768291;6429.742810287723;6505.60966342021;6509;6096.817095487142;6097.695115244309;6136.5090792737365;6195.862427462518;6239.78160764371;6199.388159078582;6212.844678883064;6214.751409943732;6235.906461402992;6254.499640028877;4576.244919588231;4938.604911607134;5914.558606082329;6097.939020609737;6098.573099883143;4773.522647735199;4930.309756634146;5920.79277225295;6242.812715618538;6423;5578.665280083208;5850.005499065254;6013.879722405615;6077.848053798691;6113.663748493876 17:51:44 INFO - PID 1909 | |5;yui.html;706.3007622453772;738.5974643819118;787.8345547435039;844.6790219716503;857.1128881607538;13159.736805263901;17760.64478710425;18013.63972720545;18745.906270468662;18754.812451875478;16977.83022169778;17037.57406064849;17378.652426951452;17429.564260893483;17464.301427942868;913.0686699566438;928.7910220200434;931.1154403316842;932.0865551759246;941.9717408477723;674.83803887067;693.143967200507;965.242284806427;971.0047201618327;975.8194733974202;934.5047125023748;1028.7582418131733;1030.8608337874366;1034.0383443397636;1035.8394448860402;1025.1696126137851;1027.0551092994426;1027.671145233518;1028.3624153025098;1030.8814486334054;753.4311594745986;753.600591686407;755.5957562703927;757.2011527838129;761.3680645064638;14575.416983320654;15072.924635376863;16380.672386552202;16543.669126617522;17133.82866171335;16548.83451165497;16654.916725416297;16877.40929067477;16967.660646787117;17143.82856171435;13787.931060344734;14029.719405611831;14031.087979281314;14195.361208745631;14257.429702811874;3431.759776815624;3454.447288433864;3456.101413632474;3459.5502584664086;3459.584849818038;126215.36892315572;127060;127939;129365.35317323447;129848;10962.013418792347;12007.099467539969;12072.45673944657;12166.878331216574;12246.142770006014;18677.06614669261;19064.2374305029;24484.510309793703;24731.752682473303;25479.872600636878;7484.625768711543;7786.377089832799;7790.766277011699;7792.766217013499;7798.025246844145;3781.905452363658;3800.771953682788;3808.5429748430365;3854.807259637007;3856.9807150964066;4264.488261408589;4301.462317210348;4341.978290108593;4374.321980093091;4382.430284063052;866.3147163417598;900.4012331799411;906.3881879731155;908.4912449028565;914.6707185413246;663.6018388966678;669.8660267946333;676.3912478769147;687.0450074396592;708.7377670261933;9384.765380865532;10981.17641176915;11548;11927.165098443025;12023.21849079807;650.9316521765146;665.3213722003529;666.4901350466897;668.8528523724773;690.5649440852231;5434.456554344534;5446.509814116748;5565.387807341189;5635.295588051494;5695.886082278331;108831.2792180186;109913.45043274733;113153;116418.8358116425;116499.41750291194;73176.63411683014;96815;102688.48655756674;102712;102890;60823;86709.13290867137;89416.10583894208;89597.65603515822;90427.54786226158;9983.60065597397;10576.101031412416;11272.605458808903;11375.43122843871;11417.942910285396;30245.546316804826;40259.79870100631;41333.37999929943;41353;42200.57799422089;67740.96777096695;70544.23639409056;73868;75487;75667;16219;16242.837571624605;16514.83485165133;16576.171191440622;16587.66824663524;14030.596940305888;16816.243269052677;17860.55348616295;18210.635787284446;18503;16660.00039997604;16772;17588.38440654571;17588.472345829647;17739.93560386381;14173.716525669635;16484.505464836075;16642;17153.571160721083;17669.204885779913;16130.032198068153;16197.271122799266;16509.422170223985;16703.83296167023;16957.321707131578;11532.827007594726;11744.354060526754;11857.11071669611;11965.581204657796;11976.92207701311;12778.23330600167;13069.934650326688;13944.860551394357;13983.860161398256;14158.929205353907 17:51:44 INFO - PID 1909 | __end_tp_report 17:51:44 INFO - PID 1909 | __start_cc_report 17:51:44 INFO - PID 1909 | _x_x_mozilla_cycle_collect,2574 17:51:44 INFO - PID 1909 | __end_cc_report 17:51:44 INFO - PID 1909 | __startTimestamp1493427104113__endTimestamp 17:51:44 INFO - PID 1909 | 17:51:44 INFO - PID 1909 | ------- Summary: start ------- 17:51:44 INFO - PID 1909 | Number of tests: 6 17:51:44 INFO - PID 1909 | 17:51:44 INFO - PID 1909 | [#0] dojo.html Cycles:165 Average:5941.66 Median:6218.56 stddev:686.09 (11.0%) stddev-sans-first:659.30 17:51:44 INFO - PID 1909 | Values: 3429.9 3432.9 3451.9 3484.0 3504.1 5868.2 6000.0 6055.8 6080.0 6108.8 5858.4 5933.5 5943.7 5949.5 5955.6 5185.1 5211.1 5213.4 5215.6 5228.9 5320.9 5323.5 5328.8 5331.1 5343.0 5316.2 5316.9 5336.3 5338.7 5339.0 5313.2 5322.6 5327.5 5333.5 5345.4 5120.7 5228.2 5253.2 5275.9 5306.6 6062.8 6089.0 6092.9 6137.9 6144.7 6390.6 6393.2 6416.8 6428.4 6455.3 4882.7 6254.9 6329.2 6463.5 6482.8 6171.3 6174.9 6181.5 6183.5 6187.9 6631.6 6631.8 6638.5 6643.6 6662.1 6210.3 6293.3 6302.1 6306.0 6343.3 6379.0 6399.6 6437.6 6438.5 6451.7 6335.9 6338.6 6347.6 6354.3 6356.3 6251.6 6274.5 6282.3 6337.9 6368.6 5038.4 5137.7 5161.9 5242.4 5251.1 4557.3 4558.8 4576.0 4629.8 4638.9 6102.4 6138.3 6147.4 6150.7 6166.9 6384.5 6456.0 6457.5 6462.6 6468.3 5956.5 6054.4 6060.5 6143.9 6218.6 5677.8 5726.9 5739.3 5745.0 5746.1 6644.0 6656.9 6669.7 6673.8 6673.9 6397.8 6419.0 6443.7 6478.1 6489.1 6422.7 6518.9 6527.8 6529.8 6669.7 6327.6 6328.5 6337.2 6343.8 6347.1 4495.0 6300.2 6404.9 6450.5 6468.9 6311.5 6328.1 6332.0 6345.2 6348.8 5707.4 6328.9 6341.5 6349.2 6371.6 6079.0 6119.0 6125.2 6282.5 6287.7 6259.4 6302.8 6320.2 6322.8 6327.6 6215.6 6233.2 6240.7 6250.2 6257.0 17:51:44 INFO - PID 1909 | 17:51:44 INFO - PID 1909 | [#1] ext.html Cycles:180 Average:46467.70 Median:35720.82 stddev:81604.50 (228.5%) stddev-sans-first:81761.33 17:51:44 INFO - PID 1909 | Values: 781.3 1108.1 1126.1 1128.2 1225.6 36688.6 37910.6 37942.8 37961.6 38021.6 37483.7 37765.2 37855.2 37926.1 37929.6 5931.7 6033.6 7814.5 7955.4 7960.6 6022.4 6109.8 6111.4 6565.7 8490.5 8535.7 8574.0 8578.8 8582.4 8620.0 8473.4 8532.5 8547.6 8559.1 8565.3 5933.4 6043.2 6048.8 6049.3 8310.7 21531.6 35667.8 35773.8 35893.6 35902.1 3589.9 3619.2 3625.6 3626.6 3631.7 30445.1 30575.0 30578.7 30581.2 30620.5 2961.2 3145.2 3160.1 3162.2 3199.4 281580.0 285666.0 287087.0 287896.6 289722.0 39817.8 39866.8 40119.0 48876.5 49104.8 49333.0 49530.5 49641.1 49662.8 50044.2 13702.6 13787.2 13793.1 13803.3 13805.6 11220.9 11222.7 11226.3 11228.8 11246.2 12713.7 12716.6 12729.8 12787.8 12829.2 5460.8 5479.8 5484.5 5489.2 5502.7 844.0 980.2 991.4 1011.4 1018.5 23212.0 24138.0 30653.2 31024.4 31383.7 970.1 995.2 1103.7 1114.3 1143.7 12523.5 12698.3 12840.9 12847.2 12881.5 310369.0 335217.0 335534.0 335646.0 335791.0 48356.8 56051.9 56234.0 56412.7 56490.0 1526.8 1533.6 1575.3 1581.7 1592.3 24589.6 29973.8 30249.4 30672.7 30675.4 54192.7 54651.6 54703.0 54719.0 54723.7 311915.0 313767.0 313871.0 314013.0 314955.0 35922.1 36747.8 37206.0 37292.8 37316.8 44761.8 45671.3 46413.5 47038.3 47149.5 30380.2 31141.4 31815.8 31876.9 32267.2 30980.0 31415.5 31684.4 31848.5 31892.6 38284.0 38398.5 38462.8 38526.8 38533.4 24511.1 28461.6 30417.0 31744.7 32166.7 22981.8 24787.0 24869.0 24986.8 24999.9 17:51:44 INFO - PID 1909 | 17:51:44 INFO - PID 1909 | [#2] jquery.html Cycles:180 Average:35349.25 Median:12743.28 stddev:93289.41 (732.1%) stddev-sans-first:93514.17 17:51:44 INFO - PID 1909 | Values: 385.1 424.2 432.6 444.9 448.4 16936.0 21107.9 21506.7 22249.0 22547.9 22434.7 22738.5 23183.4 23205.9 23286.4 4861.9 6044.0 6237.3 6273.9 6299.1 6096.7 6212.1 6212.6 6213.7 6216.3 6025.5 6072.1 6115.0 6149.6 6199.7 5061.8 5628.8 5735.7 6054.4 6164.4 5237.4 5474.9 5486.3 5487.8 5489.6 26563.2 26612.6 26664.5 26713.9 26746.6 2253.4 2299.5 2299.9 2300.1 2303.1 17421.7 17815.9 18029.8 18037.5 18051.9 1769.8 2102.5 2165.0 2172.3 2181.3 149654.0 150146.0 150922.0 151192.5 154187.0 9680.1 10163.4 11375.6 11881.2 12557.3 13511.7 15378.2 16244.7 16798.0 16872.2 8821.4 8864.6 8931.3 9047.2 9113.2 8469.2 8496.7 8503.4 8674.7 8682.6 6410.4 7685.3 7803.8 7841.6 7845.8 1843.8 2183.2 2205.2 2206.1 2221.9 824.7 956.9 963.5 975.8 1009.5 21210.8 21897.7 22076.4 25673.0 27768.9 982.4 988.0 997.4 1016.5 1023.6 10931.7 11294.4 11382.9 11443.9 11486.6 449703.0 560266.0 567430.0 578323.0 580754.0 135458.0 136074.0 138711.0 141965.0 143487.6 1168.7 1211.5 1221.2 1222.4 1231.4 18568.8 18908.8 18967.1 18982.6 19165.0 51183.0 52270.0 53056.7 54229.7 54813.5 64273.7 68940.0 69774.0 71022.3 71195.6 8921.5 8942.6 9071.3 9128.0 9164.5 14329.8 14427.1 14638.0 14782.3 14853.9 11357.2 11446.0 11705.7 11934.5 12264.8 10009.4 10175.1 10977.1 11188.0 11441.9 11801.8 12158.0 12516.6 12531.5 12631.5 8837.4 9027.5 9114.2 9155.3 9355.4 9953.3 11029.6 11948.5 11971.6 12290.1 17:51:44 INFO - PID 1909 | 17:51:44 INFO - PID 1909 | [#3] mootools.html Cycles:180 Average:7057.15 Median:3810.44 stddev:4490.80 (117.9%) stddev-sans-first:4481.80 17:51:44 INFO - PID 1909 | Values: 1195.5 1443.3 1460.7 1463.2 1471.4 11054.9 11589.0 11589.9 11592.6 11616.2 10488.4 11509.5 11652.8 11663.0 11668.9 2495.6 2542.6 2543.8 2545.2 2546.2 2045.1 2363.3 2501.6 2502.7 2506.6 2124.2 2226.2 2521.8 2523.7 2523.8 2472.9 2480.8 2496.6 2498.3 2500.1 2485.0 2485.4 2489.9 2489.9 2494.8 11447.0 11452.5 11598.8 11600.3 11619.3 6475.4 6734.6 6739.5 6743.4 6744.3 3319.3 4099.1 4240.3 4246.8 4258.1 1240.4 1241.4 1264.4 1269.6 1279.6 16210.7 16349.9 16360.3 16365.3 16368.8 5274.7 5315.7 5461.6 5562.2 5590.2 11626.3 11629.5 11632.4 11633.0 11664.9 6500.3 6501.8 6505.1 6513.9 6522.5 4561.7 6169.5 6186.9 6212.3 6247.8 3637.0 4119.3 4285.6 4300.1 4342.0 1263.1 1266.0 1283.0 1284.5 1291.8 668.6 701.9 788.6 798.4 807.1 6719.6 6780.2 6843.3 7016.4 7035.6 569.3 609.0 612.0 612.8 710.3 3983.9 4470.6 4484.9 4534.3 4718.0 14577.5 15148.3 15156.8 15202.0 15280.0 14406.9 14819.9 14950.9 14957.5 15032.5 8259.0 8474.6 8517.3 8522.0 8556.0 6039.7 6956.5 6986.3 7017.8 7069.2 13085.8 13602.9 13610.5 13908.7 13924.7 13312.2 13575.5 14082.9 14112.9 14144.6 9029.0 9258.7 9421.5 9423.0 9429.2 9856.7 10000.9 10008.5 10012.2 10022.9 8199.4 9001.5 9074.7 9085.0 9109.5 8734.1 8848.7 8861.8 8935.7 8956.3 8160.2 8180.3 8264.5 8271.6 8293.1 5963.4 6000.8 6124.9 6135.8 6215.8 5661.2 6008.5 6027.5 6164.8 6270.0 17:51:44 INFO - PID 1909 | 17:51:44 INFO - PID 1909 | [#4] prototype.html Cycles:180 Average:4987.49 Median:5662.22 stddev:1567.15 (27.7%) stddev-sans-first:1532.98 17:51:44 INFO - PID 1909 | Values: 384.1 387.1 396.9 407.9 408.4 5622.5 5798.5 5878.1 5922.4 5993.2 5558.4 5636.3 5751.9 5792.4 5814.7 4381.2 4494.5 4496.5 4500.3 4507.2 3920.9 4139.0 4477.6 4485.8 4488.7 3907.0 4407.4 4432.1 4446.5 4463.4 3597.2 3672.6 3983.9 4075.5 4450.5 3242.5 3893.7 3961.5 3985.6 4004.6 5630.5 5640.9 5653.7 5674.5 5715.0 4418.9 4526.6 5256.0 5272.5 5347.7 5577.8 5943.5 6168.0 6188.8 6212.7 4499.0 4545.3 4545.9 4548.7 4553.4 5961.8 6187.0 6491.7 6514.3 6540.3 3661.0 4016.9 4101.9 4161.4 4166.5 3526.3 3536.8 4226.7 4235.1 4255.0 4819.2 4959.0 4976.5 4977.6 4997.8 5243.0 5858.7 6166.3 6182.0 6233.3 1279.5 1366.2 1383.2 1402.3 1430.2 764.2 819.4 895.5 932.4 939.4 5170.1 5846.9 5893.2 5903.5 5907.4 5399.6 6307.6 6319.5 6330.6 6358.0 5597.8 5722.8 5812.5 5860.7 5870.4 2850.8 3041.0 3073.8 3214.5 3331.6 5460.7 5545.8 6404.7 6452.6 6582.8 5670.8 6503.4 6525.3 6525.9 6530.1 6372.6 6533.5 6557.2 6567.0 6612.0 5034.7 5593.4 6053.7 6302.6 6373.6 6282.1 6290.8 6303.6 6309.0 6312.3 5541.4 5829.1 6245.1 6617.0 6708.0 3974.4 4160.8 4165.1 4179.1 4190.5 6179.3 6271.8 6429.7 6505.6 6509.0 6096.8 6097.7 6136.5 6195.9 6239.8 6199.4 6212.8 6214.8 6235.9 6254.5 4576.2 4938.6 5914.6 6097.9 6098.6 4773.5 4930.3 5920.8 6242.8 6423.0 5578.7 5850.0 6013.9 6077.8 6113.7 17:51:44 INFO - PID 1909 | 17:51:44 INFO - PID 1909 | [#5] yui.html Cycles:180 Average:22536.65 Median:18112.14 stddev:32669.12 (180.4%) stddev-sans-first:32719.64 17:51:44 INFO - PID 1909 | Values: 706.3 738.6 787.8 844.7 857.1 13159.7 17760.6 18013.6 18745.9 18754.8 16977.8 17037.6 17378.7 17429.6 17464.3 913.1 928.8 931.1 932.1 942.0 674.8 693.1 965.2 971.0 975.8 934.5 1028.8 1030.9 1034.0 1035.8 1025.2 1027.1 1027.7 1028.4 1030.9 753.4 753.6 755.6 757.2 761.4 14575.4 15072.9 16380.7 16543.7 17133.8 16548.8 16654.9 16877.4 16967.7 17143.8 13787.9 14029.7 14031.1 14195.4 14257.4 3431.8 3454.4 3456.1 3459.6 3459.6 126215.4 127060.0 127939.0 129365.4 129848.0 10962.0 12007.1 12072.5 12166.9 12246.1 18677.1 19064.2 24484.5 24731.8 25479.9 7484.6 7786.4 7790.8 7792.8 7798.0 3781.9 3800.8 3808.5 3854.8 3857.0 4264.5 4301.5 4342.0 4374.3 4382.4 866.3 900.4 906.4 908.5 914.7 663.6 669.9 676.4 687.0 708.7 9384.8 10981.2 11548.0 11927.2 12023.2 650.9 665.3 666.5 668.9 690.6 5434.5 5446.5 5565.4 5635.3 5695.9 108831.3 109913.5 113153.0 116418.8 116499.4 73176.6 96815.0 102688.5 102712.0 102890.0 60823.0 86709.1 89416.1 89597.7 90427.5 9983.6 10576.1 11272.6 11375.4 11417.9 30245.5 40259.8 41333.4 41353.0 42200.6 67741.0 70544.2 73868.0 75487.0 75667.0 16219.0 16242.8 16514.8 16576.2 16587.7 14030.6 16816.2 17860.6 18210.6 18503.0 16660.0 16772.0 17588.4 17588.5 17739.9 14173.7 16484.5 16642.0 17153.6 17669.2 16130.0 16197.3 16509.4 16703.8 16957.3 11532.8 11744.4 11857.1 11965.6 11976.9 12778.2 13069.9 13944.9 13983.9 14158.9 17:51:44 INFO - PID 1909 | -------- Summary: end -------- 17:51:44 INFO - PID 1909 | 17:51:44 INFO - TEST-INFO | 1909: exit 0 17:51:44 INFO - TEST-OK | dromaeo_css | took 1118988ms 17:51:44 INFO - TEST-START | kraken 17:51:44 INFO - operating with platform_type : mac_ 17:51:44 INFO - Initialising browser for kraken test... 17:51:44 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmp8RZOKp/profile http://localhost:56919/getInfo.html) 17:51:47 INFO - PID 1914 | __metrics Screen width/height:1600/1200 17:51:47 INFO - PID 1914 | colorDepth:24 17:51:47 INFO - PID 1914 | Browser inner width/height: 1024/689 17:51:47 INFO - PID 1914 | __metrics 17:51:47 INFO - PID 1914 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:51:47 INFO - PID 1914 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:51:48 INFO - TEST-INFO | 1914: exit 0 17:51:48 INFO - Browser initialized. 17:51:48 INFO - Running cycle 1/1 for kraken test... 17:51:48 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmp8RZOKp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:52:00 INFO - PID 1915 | RSS: Main: 242335744 17:52:00 INFO - PID 1915 | 17:52:02 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56919/tests/kraken/driver.html?testName=audio-beat-detection) 17:52:03 INFO - PID 1915 | RSS: Main: 310644736 17:52:03 INFO - PID 1915 | 17:52:06 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56919/tests/kraken/driver.html?testName=audio-dft) 17:52:07 INFO - PID 1915 | RSS: Main: 292864000 17:52:07 INFO - PID 1915 | 17:52:10 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56919/tests/kraken/driver.html?testName=audio-fft) 17:52:11 INFO - PID 1915 | RSS: Main: 387432448 17:52:11 INFO - PID 1915 | 17:52:13 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56919/tests/kraken/driver.html?testName=audio-oscillator) 17:52:13 INFO - PID 1915 | RSS: Main: 290844672 17:52:13 INFO - PID 1915 | 17:52:15 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56919/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:52:16 INFO - PID 1915 | RSS: Main: 293355520 17:52:16 INFO - PID 1915 | 17:52:19 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56919/tests/kraken/driver.html?testName=imaging-darkroom) 17:52:19 INFO - PID 1915 | RSS: Main: 356413440 17:52:19 INFO - PID 1915 | 17:52:22 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56919/tests/kraken/driver.html?testName=imaging-desaturate) 17:52:23 INFO - PID 1915 | RSS: Main: 375668736 17:52:23 INFO - PID 1915 | 17:52:26 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56919/tests/kraken/driver.html?testName=json-parse-financial) 17:52:26 INFO - PID 1915 | RSS: Main: 383418368 17:52:26 INFO - PID 1915 | 17:52:28 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56919/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:52:29 INFO - PID 1915 | RSS: Main: 334118912 17:52:29 INFO - PID 1915 | 17:52:30 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56919/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:52:31 INFO - PID 1915 | RSS: Main: 334282752 17:52:31 INFO - PID 1915 | 17:52:33 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56919/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:52:34 INFO - PID 1915 | RSS: Main: 336920576 17:52:34 INFO - PID 1915 | 17:52:37 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:52:38 INFO - PID 1915 | RSS: Main: 334213120 17:52:38 INFO - PID 1915 | 17:52:41 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:52:41 INFO - PID 1915 | RSS: Main: 344711168 17:52:41 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:56919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56919/tests/kraken/driver.html?testName=ai-astar) 17:52:43 INFO - PID 1915 | RSS: Main: 387637248 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | __start_tp_report 17:52:43 INFO - PID 1915 | _x_x_mozilla_page_load 17:52:43 INFO - PID 1915 | _x_x_mozilla_page_load_details 17:52:43 INFO - PID 1915 | |i|pagename|runs| 17:52:43 INFO - PID 1915 | |0;ai-astar;115;109;109;109;108;112;108;109;111;110 17:52:43 INFO - PID 1915 | |1;audio-beat-detection;144;108;107;145;110;107;103;106;132;108 17:52:43 INFO - PID 1915 | |2;audio-dft;185;183;188;265;212;186;184;186;180;185 17:52:43 INFO - PID 1915 | |3;audio-fft;82;62;61;89;59;60;59;59;91;89 17:52:43 INFO - PID 1915 | |4;audio-oscillator;93;70;87;73;94;101;109;69;70;91 17:52:43 INFO - PID 1915 | |5;imaging-gaussian-blur;87;87;87;87;88;88;88;87;88;87 17:52:43 INFO - PID 1915 | |6;imaging-darkroom;94;94;94;93;95;94;94;94;114;101 17:52:43 INFO - PID 1915 | |7;imaging-desaturate;85;83;83;84;83;83;84;84;84;86 17:52:43 INFO - PID 1915 | |8;json-parse-financial;50;49;49;47;47;50;48;48;48;49 17:52:43 INFO - PID 1915 | |9;json-stringify-tinderbox;54;61;55;58;63;57;57;58;57;57 17:52:43 INFO - PID 1915 | |10;stanford-crypto-aes;84;83;86;103;105;83;82;82;80;82 17:52:43 INFO - PID 1915 | |11;stanford-crypto-ccm;143;142;138;131;161;147;149;144;178;146 17:52:43 INFO - PID 1915 | |12;stanford-crypto-pbkdf2;187;185;189;192;183;185;189;183;194;222 17:52:43 INFO - PID 1915 | |13;stanford-crypto-sha256-iterative;68;68;67;71;59;56;73;92;94;95 17:52:43 INFO - PID 1915 | __end_tp_report 17:52:43 INFO - PID 1915 | __start_cc_report 17:52:43 INFO - PID 1915 | _x_x_mozilla_cycle_collect,2213 17:52:43 INFO - PID 1915 | __end_cc_report 17:52:43 INFO - PID 1915 | __startTimestamp1493427163960__endTimestamp 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | ------- Summary: start ------- 17:52:43 INFO - PID 1915 | Number of tests: 14 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#0] ai-astar Cycles:10 Average:110.00 Median:109.50 stddev:2.16 (2.0%) stddev-sans-first:1.33 17:52:43 INFO - PID 1915 | Values: 115.0 109.0 109.0 109.0 108.0 112.0 108.0 109.0 111.0 110.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#1] audio-beat-detection Cycles:10 Average:117.00 Median:109.00 stddev:16.55 (15.2%) stddev-sans-first:14.39 17:52:43 INFO - PID 1915 | Values: 144.0 108.0 107.0 145.0 110.0 107.0 103.0 106.0 132.0 108.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#2] audio-dft Cycles:10 Average:195.40 Median:186.00 stddev:26.01 (14.0%) stddev-sans-first:27.31 17:52:43 INFO - PID 1915 | Values: 185.0 183.0 188.0 265.0 212.0 186.0 184.0 186.0 180.0 185.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#3] audio-fft Cycles:10 Average:71.10 Median:72.00 stddev:14.54 (20.2%) stddev-sans-first:14.88 17:52:43 INFO - PID 1915 | Values: 82.0 62.0 61.0 89.0 59.0 60.0 59.0 59.0 91.0 89.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#4] audio-oscillator Cycles:10 Average:85.70 Median:80.00 stddev:14.38 (18.0%) stddev-sans-first:15.01 17:52:43 INFO - PID 1915 | Values: 93.0 70.0 87.0 73.0 94.0 101.0 109.0 69.0 70.0 91.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:87.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 17:52:43 INFO - PID 1915 | Values: 87.0 87.0 87.0 87.0 88.0 88.0 88.0 87.0 88.0 87.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#6] imaging-darkroom Cycles:10 Average:96.70 Median:94.00 stddev:6.48 (6.9%) stddev-sans-first:6.80 17:52:43 INFO - PID 1915 | Values: 94.0 94.0 94.0 93.0 95.0 94.0 94.0 94.0 114.0 101.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.00 stddev:0.99 (1.2%) stddev-sans-first:0.97 17:52:43 INFO - PID 1915 | Values: 85.0 83.0 83.0 84.0 83.0 83.0 84.0 84.0 84.0 86.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#8] json-parse-financial Cycles:10 Average:48.50 Median:49.00 stddev:1.08 (2.2%) stddev-sans-first:1.00 17:52:43 INFO - PID 1915 | Values: 50.0 49.0 49.0 47.0 47.0 50.0 48.0 48.0 48.0 49.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:57.50 stddev:2.63 (4.6%) stddev-sans-first:2.42 17:52:43 INFO - PID 1915 | Values: 54.0 61.0 55.0 58.0 63.0 57.0 57.0 58.0 57.0 57.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:82.50 stddev:9.10 (11.0%) stddev-sans-first:9.59 17:52:43 INFO - PID 1915 | Values: 84.0 83.0 86.0 103.0 105.0 83.0 82.0 82.0 80.0 82.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:146.50 stddev:13.08 (8.9%) stddev-sans-first:13.76 17:52:43 INFO - PID 1915 | Values: 143.0 142.0 138.0 131.0 161.0 147.0 149.0 144.0 178.0 146.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.90 Median:189.00 stddev:11.52 (6.1%) stddev-sans-first:12.13 17:52:43 INFO - PID 1915 | Values: 187.0 185.0 189.0 192.0 183.0 185.0 189.0 183.0 194.0 222.0 17:52:43 INFO - PID 1915 | 17:52:43 INFO - PID 1915 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:72.00 stddev:14.31 (19.9%) stddev-sans-first:15.00 17:52:43 INFO - PID 1915 | Values: 68.0 68.0 67.0 71.0 59.0 56.0 73.0 92.0 94.0 95.0 17:52:43 INFO - PID 1915 | -------- Summary: end -------- 17:52:43 INFO - PID 1915 | 17:52:44 INFO - TEST-INFO | 1915: exit 0 17:52:45 INFO - TEST-OK | kraken | took 60270ms 17:52:45 INFO - SUITE-END | took 1179s 17:52:45 INFO - Completed test suite (00:19:39) 17:52:45 INFO - javascript benchmark 17:52:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7721.455360839468, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3429.8971030869084, 3432.897013089608, 3451.8619255229787, 3484.0070579884737, 3504.071421073416, 5868.207791948085, 6000.0, 6055.757769689213, 6079.9999999999945, 6108.786192483264, 5858.3596592954045, 5933.525317974551, 5943.702814859262, 5949.49429298509, 5955.612885162462, 5185.092608793456, 5211.114110601206, 5213.426523082458, 5215.582753379739, 5228.947710522884, 5320.866978325554, 5323.494268044549, 5328.813491527797, 5331.067063263933, 5342.98483288176, 5316.20256961455, 5316.893662126755, 5336.332958380202, 5338.652987555816, 5339.0, 5313.1764576490705, 5322.627416080876, 5327.520523152934, 5333.546648534879, 5345.412004679482, 5120.6927584344685, 5228.215767634847, 5253.212018197263, 5275.920861187085, 5306.628536002481, 6062.818115456544, 6089.0, 6092.939070609282, 6137.877242455171, 6144.723487443076, 6390.6485143317095, 6393.168888044571, 6416.775412860574, 6428.4214420702365, 6455.257645370749, 4882.731449770261, 6254.874902501924, 6329.240491141047, 6463.515236357292, 6482.805515834532, 6171.290301615327, 6174.938250617436, 6181.474574661159, 6183.505319574513, 6187.938120618781, 6631.602103873783, 6631.801045968628, 6638.4689224861895, 6643.60138391698, 6662.067310576524, 6210.31686514483, 6293.2762732285455, 6302.1492098566105, 6305.96847015762, 6343.270523889812, 6378.968105159444, 6399.584027038228, 6437.645929473831, 6438.484921206292, 6451.741930322828, 6335.904961425582, 6338.619682819046, 6347.619142851444, 6354.332795056545, 6356.332585078592, 6251.562390632703, 6274.466670333073, 6282.340354262737, 6337.873242535124, 6368.554201205964, 5038.370203724535, 5137.717425541631, 5161.948380516222, 5242.397124330674, 5251.133562962068, 4557.316402539579, 4558.840440584564, 4576.0161565263625, 4629.814807407666, 4638.930416043762, 6102.389761023862, 6138.281281241259, 6147.44672979434, 6150.7232174552255, 6166.920788861931, 6384.48924086072, 6456.031595260654, 6457.5479716419395, 6462.644554549451, 6468.320826313169, 5956.493698035715, 6054.3945605439985, 6060.484858786965, 6143.938560614426, 6218.5647004709235, 5677.77288908439, 5726.942730572641, 5739.282589676291, 5745.023346031185, 5746.0519014363, 6644.036614690843, 6656.866862662817, 6669.6665166740495, 6673.833154171185, 6673.8998915015345, 6397.840053998687, 6418.967905160444, 6443.67781610927, 6478.125453063776, 6489.091527186292, 6422.743090276336, 6518.934810651833, 6527.771527996498, 6529.771457998947, 6669.699863506057, 6327.588706734047, 6328.493720502257, 6337.207849018872, 6343.777967771106, 6347.143135676809, 4494.977525112354, 6300.243970723359, 6404.93595064062, 6450.516211284079, 6468.902966455601, 6311.463525600376, 6328.0507923809955, 6331.96834015827, 6345.206849143857, 6348.809535713936, 5707.400722924033, 6328.936710632835, 6341.460975816923, 6349.238091429058, 6371.55399122057, 6078.969605151946, 6119.015143218386, 6125.235451818428, 6282.528810339151, 6287.685615719104, 6259.436650701458, 6302.779402720883, 6320.178376810985, 6322.841928951813, 6327.620342779448, 6215.627062376272, 6233.158523599256, 6240.656763878031, 6250.156228909039, 6257.0], "value": 5897.794907654891, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.2734157233772, 1108.074757577423, 1126.1385040444056, 1128.2271643923918, 1225.6261840138754, 36688.63311366885, 37910.620893791056, 37942.8102859486, 37961.62038379615, 38021.619783802154, 37483.68807091746, 37765.244695106085, 37855.24289514208, 37926.0518487038, 37929.620703792956, 5931.703414829263, 6033.577649564532, 7814.452988290807, 7955.363570914313, 7960.562169080698, 6022.397760223965, 6109.816705498843, 6111.449969502743, 6565.737370505174, 8490.490570565786, 8535.701250456235, 8573.957130214372, 8578.828423431527, 8582.399232053758, 8620.008698999633, 8473.406861519665, 8532.488050716976, 8547.572621368938, 8559.101294364064, 8565.314774818, 5933.436323549256, 6043.214382130295, 6048.788292409745, 6049.334573196945, 8310.70912518059, 21531.56936861254, 35667.82166089153, 35773.82113089444, 35893.64106358929, 35902.10244743876, 3589.8564057437934, 3619.2037751694584, 3625.583057948343, 3626.601073881871, 3631.673149416565, 30445.086647400614, 30575.0, 30578.69421305803, 30581.235469113228, 30620.54069188964, 2961.2448825549563, 3145.1665308693214, 3160.0993716790604, 3162.2252548125625, 3199.376121656278, 281580.0, 285666.0, 287087.0, 287896.5605171982, 289722.0, 39817.80546583607, 39866.80066599706, 40119.0, 48876.511234887905, 49104.77238069077, 49333.0, 49530.504694952586, 49641.05025296461, 49662.75168624134, 50044.249336259985, 13702.588922332347, 13787.241701706502, 13793.10344827583, 13803.309834508234, 13805.585832425044, 11220.887791122148, 11222.66332010041, 11226.326420414802, 11228.775424491629, 11246.156538259664, 12713.682157946125, 12716.554920577735, 12729.809052864215, 12787.808182877265, 12829.166104203197, 5460.754266058037, 5479.808206712746, 5484.533814625722, 5489.204065410493, 5502.697351645698, 843.9535825529655, 980.1570649241646, 991.4002028772488, 1011.3577878047493, 1018.5212949913529, 23212.0, 24138.0, 30653.23366915845, 31024.379512409625, 31383.686163138533, 970.1026550440955, 995.1789773436943, 1103.690966529373, 1114.2812885688686, 1143.7083543696472, 12523.499060037497, 12698.301698301699, 12840.908522775482, 12847.164934279243, 12881.484740610458, 310369.0, 335217.0, 335534.0, 335646.0, 335791.0, 48356.75821620869, 56051.878962420524, 56234.0, 56412.717936410874, 56490.0, 1526.8167819861687, 1533.555268972008, 1575.298991948595, 1581.7311057120316, 1592.2834724373847, 24589.639522562415, 29973.801047957837, 30249.395012099194, 30672.693273066983, 30675.386492270474, 54192.72903635457, 54651.63370915759, 54703.0, 54719.0, 54723.72638136784, 311915.0, 313767.0, 313871.0, 314013.0, 314955.0, 35922.10194745048, 36747.816260918524, 37206.0, 37292.81353593323, 37316.813415932746, 44761.776191118835, 45671.31493027541, 46413.535864642276, 47038.294425584325, 47149.528504714515, 30380.24049398783, 31141.377172456876, 31815.840920795246, 31876.884309049074, 32267.193320167185, 30979.970572644914, 31415.528767068055, 31684.36631267408, 31848.52227216547, 31892.564834582034, 38284.0, 38398.54413102834, 38462.807685961394, 38526.80736596299, 38533.42199866948, 24511.142110026063, 28461.592297463416, 30417.0, 31744.682553174174, 32166.67833321637, 22981.77018229796, 24787.0, 24869.0, 24986.823393696934, 24999.87500062488], "value": 17571.979664470167, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.09886864736546, 424.16982502994716, 432.63226257680975, 444.85097492340066, 448.394667199281, 16936.0, 21107.894460527714, 21506.709597424164, 22249.0, 22547.887260563715, 22434.663480047813, 22738.521996070285, 23183.420414489647, 23205.883970580122, 23286.41783955402, 4861.857463496076, 6043.969780151093, 6237.313895471494, 6273.937260627404, 6299.1496148020115, 6096.695165241742, 6212.068189771525, 6212.565120441571, 6213.66406222662, 6216.347283535231, 6025.517958563326, 6072.08918662202, 6114.957622060394, 6149.631022138686, 6199.659018753967, 5061.822836200715, 5628.817948230856, 5735.655860648353, 6054.424829641177, 6164.3835616438, 5237.423883372826, 5474.91787623186, 5486.31421072366, 5487.807926722546, 5489.560835133179, 26563.203103906915, 26612.600810987657, 26664.466710665678, 26713.866430667917, 26746.598801018, 2253.425376528991, 2299.528596637685, 2299.8735069571167, 2300.1374484568287, 2303.1478353009493, 17421.738673919903, 17815.910920445443, 18029.819701803077, 18037.458876233602, 18051.9240287366, 1769.761082253905, 2102.5479521902867, 2164.9865624968775, 2172.250573552122, 2181.345596321097, 149654.0, 150146.0, 150922.0, 151192.48807511895, 154187.0, 9680.128788408936, 10163.441010744333, 11375.601853935073, 11881.168318217815, 12557.309347985949, 13511.729765404834, 15378.231088445533, 16244.675106497803, 16798.0, 16872.240749166318, 8821.38250322484, 8864.601092950703, 8931.330150238759, 9047.185753282236, 9113.225375842994, 8469.153084691605, 8496.66013359471, 8503.447275927168, 8674.696385626472, 8682.565871706389, 6410.423061924449, 7685.308322250912, 7803.843923121619, 7841.5687137208, 7845.843083138419, 1843.8340549350355, 2183.159483598794, 2205.22817014047, 2206.0734491513604, 2221.922232721847, 824.7360844529812, 956.9473678947586, 963.450833025183, 975.7560609847538, 1009.485162567096, 21210.787892120883, 21897.671534926987, 22076.448088797908, 25673.0, 27768.861155694496, 982.3860087445347, 987.9950600246952, 997.3941953454931, 1016.5476363018533, 1023.6110278094277, 10931.672049838518, 11294.378809165575, 11382.886171138183, 11443.885561144281, 11486.59796907121, 449703.0, 560266.0, 567430.0, 578323.0, 580754.0, 135458.0, 136074.0, 138711.0, 141965.0, 143487.5651243495, 1168.707823044239, 1211.4911737070452, 1221.1635030004297, 1222.376587940157, 1231.4150778380376, 18568.814311857248, 18908.810911890705, 18967.146478408227, 18982.620347592696, 19165.041747912826, 51183.0, 52270.0, 53056.73471632617, 54229.72885135549, 54813.451865480834, 64273.67863160841, 68940.0, 69773.95339069817, 71022.28977710157, 71195.64402177956, 8921.464712117293, 8942.552872356486, 9071.319651026331, 9128.041555636562, 9164.495952722664, 14329.78505322442, 14427.116073477731, 14638.048526845721, 14782.260886955393, 14853.85146148568, 11357.204995650556, 11446.02708769764, 11705.707357316136, 11934.462949167135, 12264.75470490603, 10009.449480278654, 10175.084242418217, 10977.121830253402, 11188.0, 11441.885581144083, 11801.82297265559, 12158.02735781153, 12516.557946564768, 12531.498740050296, 12631.494740210288, 8837.381383303107, 9027.45835249887, 9114.225290850352, 9155.26757859383, 9355.391899526508, 9953.253505986935, 11029.61396351124, 11948.46231919583, 11971.580994665144, 12290.139690221598], "value": 10371.207264339384, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1195.4739914437646, 1443.285573641048, 1460.656745664769, 1463.187930698462, 1471.4114354258302, 11054.889451105486, 11589.014933730632, 11589.884101158987, 11592.59425920093, 11616.186866919319, 10488.37069775814, 11509.539618415254, 11652.825207621892, 11663.008644265248, 11668.941655291734, 2495.5882279423918, 2542.5931850903858, 2543.78377837884, 2545.2109845947816, 2546.248856587302, 2045.1410407628832, 2363.3382652857226, 2501.6372625969225, 2502.674652295199, 2506.586413241822, 2124.2034237161065, 2226.1985685153413, 2521.760432758885, 2523.671922650053, 2523.83595066321, 2472.9134480293283, 2480.8263421560496, 2496.6005439129835, 2498.287987923451, 2500.1499490173337, 2485.030837973192, 2485.378655336166, 2489.8630575318352, 2489.8755062246814, 2494.77547020769, 11447.0, 11452.541898324058, 11598.826017609743, 11600.30398176112, 11619.302841829518, 6475.352464753534, 6734.56225345351, 6739.5282330236905, 6743.35938085881, 6744.325567443217, 3319.3195394943978, 4099.098198396348, 4240.342746874239, 4246.787660616957, 4258.127083947814, 1240.4232032105115, 1241.416534228911, 1264.4310060472824, 1269.581038257373, 1279.62890761679, 16210.675786484204, 16349.918250408791, 16360.345586176538, 16365.34538618454, 16368.83631163697, 5274.709890955957, 5315.707636079976, 5461.617686761889, 5562.221289019541, 5590.2453168821685, 11626.302421854716, 11629.47667354971, 11632.360220187802, 11633.0, 11664.94167529157, 6500.3174666659315, 6501.837454063591, 6505.056766768792, 6513.869722605521, 6522.543421960418, 4561.657875659339, 6169.537284703665, 6186.948218802814, 6212.285587157535, 6247.843803904939, 3637.018005138598, 4119.258533463945, 4285.5928686774705, 4300.0969796343115, 4342.0, 1263.1158189267367, 1265.9810102848464, 1282.9679258018436, 1284.466946217328, 1291.7674818532566, 668.6155460610169, 701.8701540215077, 788.5978151142958, 798.4450806689412, 807.0799288810761, 6719.563228390139, 6780.1524809398825, 6843.281455447206, 7016.403605693573, 7035.6482175891, 569.2855466389655, 608.975640974365, 611.9510439164945, 612.8161551534522, 710.2719712294939, 3983.8605648802154, 4470.619997300201, 4484.887877803081, 4534.2745160774775, 4717.976410117927, 14577.489787857374, 15148.318325675371, 15156.772648410282, 15202.011869228465, 15280.006799557994, 14406.927965360106, 14819.925900370645, 14950.925245373703, 14957.476488322856, 15032.473863414729, 8258.958705206436, 8474.618642161118, 8517.276031537265, 8521.977362716514, 8556.0, 6039.701464185221, 6956.530431696675, 6986.336298051677, 7017.754378596725, 7069.187043489859, 13085.803712944504, 13602.86397136016, 13610.523631672844, 13908.721825563634, 13924.721505570034, 13312.201267923956, 13575.456981720621, 14082.929585352007, 14112.88306753954, 14144.575662730134, 9028.954855225682, 9258.72223833286, 9421.528923553658, 9422.95288523553, 9429.198518126037, 9856.655017074369, 10000.949995249977, 10008.499575021075, 10012.19902407791, 10022.899771002489, 8199.385046121684, 9001.504917229615, 9074.682386116454, 9085.046070162538, 9109.498977556297, 8734.126587341216, 8848.690295839615, 8861.822763544822, 8935.731928042169, 8956.28349732033, 8160.183981601793, 8180.345572354078, 8264.462809917337, 8271.627776750182, 8293.087760346236, 5963.4334738199805, 6000.789972350947, 6124.8775024500155, 6135.815925522242, 6215.81352559424, 5661.179129026185, 6008.459238668541, 6027.457528822427, 6164.753409863734, 6269.968650156902], "value": 5281.142937655216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.1414438729439, 387.13282247765017, 396.88887111608744, 407.9469668943038, 408.397613520058, 5622.526088521058, 5798.507126894219, 5878.0609695152425, 5922.407759224076, 5993.190919225904, 5558.416366281543, 5636.2954630671165, 5751.884962300752, 5792.420757924216, 5814.651120932747, 4381.211381951255, 4494.460664720238, 4496.505384407713, 4500.324951257321, 4507.166174257756, 3920.901977450558, 4139.006638406776, 4477.6417886569, 4485.820567177309, 4488.655951316274, 3906.980465097685, 4407.382966384709, 4432.11357728454, 4446.488653804805, 4463.352813841991, 3597.244578638489, 3672.577653569847, 3983.900402489932, 4075.53131389891, 4450.465944086698, 3242.4649932761067, 3893.7469064510715, 3961.524617045944, 3985.561588225293, 4004.6395824375945, 5630.479770461993, 5640.943590564083, 5653.660780353151, 5674.546036317085, 5715.028055501428, 4418.889527761799, 4526.615237704799, 5256.001359741636, 5272.499112584298, 5347.732613369316, 5577.776888924438, 5943.494802941756, 6167.982282923313, 6188.783392581238, 6212.695333979869, 4498.977505112486, 4545.250033744428, 4545.909081818379, 4548.681592288541, 4553.362529245908, 5961.821145365646, 6186.958303759749, 6491.67541622917, 6514.283428822826, 6540.313267106981, 3661.029827095822, 4016.9397459038137, 4101.938470922939, 4161.417401563784, 4166.479190101238, 3526.3476256892045, 3536.840842162109, 4226.725262857966, 4235.1317979814685, 4255.0, 4819.156647586658, 4959.0329885671945, 4976.502349765067, 4977.552020318189, 4997.775100120503, 5243.0, 5858.677772722541, 6166.290876549165, 6181.96909015452, 6233.254688687175, 1279.4818098670053, 1366.2075995922341, 1383.2046573220236, 1402.3128666953323, 1430.1919415530192, 764.2472164917551, 819.4059307002376, 895.4761464543316, 932.4009324009221, 939.4128669581512, 5170.087067784869, 5846.853828654318, 5893.233879595711, 5903.527717782567, 5907.438793314628, 5399.622026458111, 6307.590006649553, 6319.46284565817, 6330.588511746721, 6357.96821015892, 5597.776088956396, 5722.7982123753645, 5812.505936995318, 5860.7436137087525, 5870.354261031283, 2850.800443968944, 3041.0, 3073.800202986799, 3214.517822326623, 3331.617893206321, 5460.726963651881, 5545.805896793593, 6404.679766011774, 6452.5805822622315, 6582.80251592453, 5670.773169073191, 6503.447206987459, 6525.347465253437, 6525.869482610321, 6530.09410812184, 6372.58578192416, 6533.490246140389, 6557.180352455943, 6566.967165164144, 6611.966940165268, 5034.672746271481, 5593.384727680033, 6053.697315134314, 6302.558820882494, 6373.649449280334, 6282.057691346335, 6290.836195303884, 6303.590266632654, 6308.968455157878, 6312.3056463788025, 5541.445855414588, 5829.067349224104, 6245.125682404376, 6616.974368972625, 6708.0, 3974.4237085623, 4160.791960401907, 4165.1461450401985, 4179.059711564995, 4190.476190476191, 6179.258488981351, 6271.78048768291, 6429.742810287723, 6505.60966342021, 6509.0, 6096.817095487142, 6097.695115244309, 6136.5090792737365, 6195.862427462518, 6239.78160764371, 6199.388159078582, 6212.844678883064, 6214.751409943732, 6235.906461402992, 6254.499640028877, 4576.244919588231, 4938.604911607134, 5914.558606082329, 6097.939020609737, 6098.573099883143, 4773.522647735199, 4930.309756634146, 5920.79277225295, 6242.812715618538, 6423.0, 5578.665280083208, 5850.005499065254, 6013.879722405615, 6077.848053798691, 6113.663748493876], "value": 4493.171840793847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.3007622453772, 738.5974643819118, 787.8345547435039, 844.6790219716503, 857.1128881607538, 13159.736805263901, 17760.64478710425, 18013.63972720545, 18745.906270468662, 18754.812451875478, 16977.83022169778, 17037.57406064849, 17378.652426951452, 17429.564260893483, 17464.301427942868, 913.0686699566438, 928.7910220200434, 931.1154403316842, 932.0865551759246, 941.9717408477723, 674.83803887067, 693.143967200507, 965.242284806427, 971.0047201618327, 975.8194733974202, 934.5047125023748, 1028.7582418131733, 1030.8608337874366, 1034.0383443397636, 1035.8394448860402, 1025.1696126137851, 1027.0551092994426, 1027.671145233518, 1028.3624153025098, 1030.8814486334054, 753.4311594745986, 753.600591686407, 755.5957562703927, 757.2011527838129, 761.3680645064638, 14575.416983320654, 15072.924635376863, 16380.672386552202, 16543.669126617522, 17133.82866171335, 16548.83451165497, 16654.916725416297, 16877.40929067477, 16967.660646787117, 17143.82856171435, 13787.931060344734, 14029.719405611831, 14031.087979281314, 14195.361208745631, 14257.429702811874, 3431.759776815624, 3454.447288433864, 3456.101413632474, 3459.5502584664086, 3459.584849818038, 126215.36892315572, 127060.0, 127939.0, 129365.35317323447, 129848.0, 10962.013418792347, 12007.099467539969, 12072.45673944657, 12166.878331216574, 12246.142770006014, 18677.06614669261, 19064.2374305029, 24484.510309793703, 24731.752682473303, 25479.872600636878, 7484.625768711543, 7786.377089832799, 7790.766277011699, 7792.766217013499, 7798.025246844145, 3781.905452363658, 3800.771953682788, 3808.5429748430365, 3854.807259637007, 3856.9807150964066, 4264.488261408589, 4301.462317210348, 4341.978290108593, 4374.321980093091, 4382.430284063052, 866.3147163417598, 900.4012331799411, 906.3881879731155, 908.4912449028565, 914.6707185413246, 663.6018388966678, 669.8660267946333, 676.3912478769147, 687.0450074396592, 708.7377670261933, 9384.765380865532, 10981.17641176915, 11548.0, 11927.165098443025, 12023.21849079807, 650.9316521765146, 665.3213722003529, 666.4901350466897, 668.8528523724773, 690.5649440852231, 5434.456554344534, 5446.509814116748, 5565.387807341189, 5635.295588051494, 5695.886082278331, 108831.2792180186, 109913.45043274733, 113153.0, 116418.8358116425, 116499.41750291194, 73176.63411683014, 96815.0, 102688.48655756674, 102712.0, 102890.0, 60823.0, 86709.13290867137, 89416.10583894208, 89597.65603515822, 90427.54786226158, 9983.60065597397, 10576.101031412416, 11272.605458808903, 11375.43122843871, 11417.942910285396, 30245.546316804826, 40259.79870100631, 41333.37999929943, 41353.0, 42200.57799422089, 67740.96777096695, 70544.23639409056, 73868.0, 75487.0, 75667.0, 16219.0, 16242.837571624605, 16514.83485165133, 16576.171191440622, 16587.66824663524, 14030.596940305888, 16816.243269052677, 17860.55348616295, 18210.635787284446, 18503.0, 16660.00039997604, 16772.0, 17588.38440654571, 17588.472345829647, 17739.93560386381, 14173.716525669635, 16484.505464836075, 16642.0, 17153.571160721083, 17669.204885779913, 16130.032198068153, 16197.271122799266, 16509.422170223985, 16703.83296167023, 16957.321707131578, 11532.827007594726, 11744.354060526754, 11857.11071669611, 11965.581204657796, 11976.92207701311, 12778.23330600167, 13069.934650326688, 13944.860551394357, 13983.860161398256, 14158.929205353907], "value": 8308.841232130799, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1453.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 109.0, 109.0, 108.0, 112.0, 108.0, 109.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 107.0, 145.0, 110.0, 107.0, 103.0, 106.0, 132.0, 108.0], "value": 117.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 188.0, 265.0, 212.0, 186.0, 184.0, 186.0, 180.0, 185.0], "value": 195.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 61.0, 89.0, 59.0, 60.0, 59.0, 59.0, 91.0, 89.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 87.0, 73.0, 94.0, 101.0, 109.0, 69.0, 70.0, 91.0], "value": 85.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 87.0, 88.0, 88.0, 88.0, 87.0, 88.0, 87.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 95.0, 94.0, 94.0, 94.0, 114.0, 101.0], "value": 96.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 84.0, 83.0, 83.0, 84.0, 84.0, 84.0, 86.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 47.0, 47.0, 50.0, 48.0, 48.0, 48.0, 49.0], "value": 48.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 61.0, 55.0, 58.0, 63.0, 57.0, 57.0, 58.0, 57.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 86.0, 103.0, 105.0, 83.0, 82.0, 82.0, 80.0, 82.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 138.0, 131.0, 161.0, 147.0, 149.0, 144.0, 178.0, 146.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 189.0, 192.0, 183.0, 185.0, 189.0, 183.0, 194.0, 222.0], "value": 190.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 71.0, 59.0, 56.0, 73.0, 92.0, 94.0, 95.0], "value": 74.3, "unit": "score"}]}]} 17:52:45 INFO - Return code: 0 17:52:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:52:45 ERROR - # TBPL SUCCESS # 17:52:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:52:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:52:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:52:45 INFO - 2017-04-28 17:52:45.258 screenresolution[1919:20078] starting screenresolution argv=screenresolution get 17:52:45 INFO - 2017-04-28 17:52:45.260 screenresolution[1919:20078] Display 0: 1600x1200x32@60 17:52:45 INFO - 2017-04-28 17:52:45.266 screenresolution[1920:20081] starting screenresolution argv=screenresolution list 17:52:45 INFO - Available Modes on Display 0 17:52:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:52:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:52:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:52:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:52:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:52:45 INFO - Intel Iris: 17:52:45 INFO - Chipset Model: Intel Iris 17:52:45 INFO - Type: GPU 17:52:45 INFO - Bus: Built-In 17:52:45 INFO - VRAM (Dynamic, Max): 1536 MB 17:52:45 INFO - Vendor: Intel (0x8086) 17:52:45 INFO - Device ID: 0x0a2e 17:52:45 INFO - Revision ID: 0x0009 17:52:45 INFO - Displays: 17:52:45 INFO - Display: 17:52:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:52:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:52:45 INFO - Display Serial Number: 1600x1200 60 17:52:45 INFO - Main Display: Yes 17:52:45 INFO - Mirror: Off 17:52:45 INFO - Online: Yes 17:52:45 INFO - Rotation: Supported 17:52:45 INFO - Return code: 0 17:52:45 INFO - Running post-action listener: _resource_record_post_action 17:52:45 INFO - [mozharness: 2017-04-29 00:52:45.514009Z] Finished run-tests step (success) 17:52:45 INFO - Running post-run listener: _resource_record_post_run 17:52:45 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 114688; Write bytes: 505077248; Read time: 5; Write time: 1828 17:52:45 INFO - TinderboxPrint: CPU usage
53.2% 17:52:45 INFO - TinderboxPrint: I/O read bytes / time
114,688 / 5 17:52:45 INFO - TinderboxPrint: I/O write bytes / time
505,077,248 / 1,828 17:52:45 INFO - TinderboxPrint: CPU idle
2,243.0 (46.8%) 17:52:45 INFO - TinderboxPrint: CPU system
956.5 (19.9%) 17:52:45 INFO - TinderboxPrint: CPU user
1,598.3 (33.3%) 17:52:45 INFO - TinderboxPrint: Swap in / out
208,928,768 / 0 17:52:45 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 197239296; Write bytes: 195807232; Read time: 15040; Write time: 455 17:52:45 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 114688; Write bytes: 292427264; Read time: 5; Write time: 1321 17:52:46 INFO - Running post-run listener: _upload_blobber_files 17:52:46 INFO - Blob upload gear active. 17:52:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:52:46 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 17:52:46 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:52:46 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:52:46 INFO - (blobuploader) - INFO - Open directory for files ... 17:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:47 INFO - (blobuploader) - INFO - Done attempting. 17:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:48 INFO - (blobuploader) - INFO - Done attempting. 17:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:49 INFO - (blobuploader) - INFO - Done attempting. 17:52:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:52:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:52:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:51 INFO - (blobuploader) - INFO - Done attempting. 17:52:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:52:51 INFO - Return code: 0 17:52:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:52:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:52:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/037498b95a8c326ebc849e4479996149268442fd33a677da705a9335e298887d3b8d78d5aff2c5a405862474a5782439109f980fad15a76df3662e1e93aa2d58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1224ee1292dc2ef3a5a831862b931bacad0be701f9620d316f55a256f0ec5b00db5be35b157bf267cfd1a3138fef628c62303923b03932c257ae79f420211887", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8fc24b5da846a23c551a9e459d5084ae46c2d55e40ad582069d7a0ea6c1a6d97e626758597066d0076375c5556e411b144a966f85c5a63f95be1a2d38aac576", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b451ee75426ae71e506db8d89076f2d205b6c2eb199d793d74113d38d42509c20179fe86042a4b077af19cb6a5909dab6a1746a50274e0cf08b3fb544fe3282"} 17:52:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:52:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:52:51 INFO - Contents: 17:52:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/037498b95a8c326ebc849e4479996149268442fd33a677da705a9335e298887d3b8d78d5aff2c5a405862474a5782439109f980fad15a76df3662e1e93aa2d58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1224ee1292dc2ef3a5a831862b931bacad0be701f9620d316f55a256f0ec5b00db5be35b157bf267cfd1a3138fef628c62303923b03932c257ae79f420211887", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8fc24b5da846a23c551a9e459d5084ae46c2d55e40ad582069d7a0ea6c1a6d97e626758597066d0076375c5556e411b144a966f85c5a63f95be1a2d38aac576", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b451ee75426ae71e506db8d89076f2d205b6c2eb199d793d74113d38d42509c20179fe86042a4b077af19cb6a5909dab6a1746a50274e0cf08b3fb544fe3282"} 17:52:51 INFO - Running post-run listener: copy_logs_to_upload_dir 17:52:51 INFO - Copying logs to upload dir... 17:52:51 INFO - mkdir: /builds/slave/test/build/upload/logs 17:52:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.518553 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-28 17:52:51.693854) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:52:51.697097) ========= 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.JVcGyCEIKi/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.q8bkt4qvys/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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/Firefox/sha512/037498b95a8c326ebc849e4479996149268442fd33a677da705a9335e298887d3b8d78d5aff2c5a405862474a5782439109f980fad15a76df3662e1e93aa2d58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1224ee1292dc2ef3a5a831862b931bacad0be701f9620d316f55a256f0ec5b00db5be35b157bf267cfd1a3138fef628c62303923b03932c257ae79f420211887", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8fc24b5da846a23c551a9e459d5084ae46c2d55e40ad582069d7a0ea6c1a6d97e626758597066d0076375c5556e411b144a966f85c5a63f95be1a2d38aac576", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b451ee75426ae71e506db8d89076f2d205b6c2eb199d793d74113d38d42509c20179fe86042a4b077af19cb6a5909dab6a1746a50274e0cf08b3fb544fe3282"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/037498b95a8c326ebc849e4479996149268442fd33a677da705a9335e298887d3b8d78d5aff2c5a405862474a5782439109f980fad15a76df3662e1e93aa2d58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1224ee1292dc2ef3a5a831862b931bacad0be701f9620d316f55a256f0ec5b00db5be35b157bf267cfd1a3138fef628c62303923b03932c257ae79f420211887", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8fc24b5da846a23c551a9e459d5084ae46c2d55e40ad582069d7a0ea6c1a6d97e626758597066d0076375c5556e411b144a966f85c5a63f95be1a2d38aac576", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b451ee75426ae71e506db8d89076f2d205b6c2eb199d793d74113d38d42509c20179fe86042a4b077af19cb6a5909dab6a1746a50274e0cf08b3fb544fe3282"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:52:51.732476) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:52:51.732795) ========= 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.JVcGyCEIKi/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.q8bkt4qvys/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005266 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:52:51.781708) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:52:51.782016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:52:51.782317) ========= ========= Total master_lag: 0.18 =========