builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0305 starttime: 1493424178.25 results: success (0) buildid: 20170428170215 builduid: 3c08f834763b4780be8fa3a566149442 revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:02:58.247866) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:02:58.248352) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:02:58.248653) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:02:58.274236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:02:58.274592) ========= 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.YLAxq6BOr8/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.RCZDjInm1L/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:02:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 5.97M=0.002s 2017-04-28 17:02:58 (5.97 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154484 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:02:58.454236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:02:58.454557) ========= 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.YLAxq6BOr8/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.RCZDjInm1L/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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.021060 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:02:58.503839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:02:58.504198) ========= 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.YLAxq6BOr8/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.RCZDjInm1L/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:02:58,596 truncating revision to first 12 chars 2017-04-28 17:02:58,596 Setting DEBUG logging. 2017-04-28 17:02:58,596 attempt 1/10 2017-04-28 17:02:58,596 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:02:59,740 unpacking tar archive at: mozilla-central-b3b32894d932/testing/mozharness/ program finished with exit code 0 elapsedTime=1.407340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:02:59.936192) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:02:59.936550) ========= script_repo_revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:02:59.936957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:02:59.937231) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:02:59.957939) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-28 17:02:59.958468) ========= /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.YLAxq6BOr8/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.RCZDjInm1L/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:03:00 INFO - MultiFileLogger online at 20170428 17:03:00 in /builds/slave/test 17:03:00 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:03:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:03:00 INFO - {'append_to_log': False, 17:03:00 INFO - 'base_work_dir': '/builds/slave/test', 17:03:00 INFO - 'blob_upload_branch': 'Firefox', 17:03:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:03:00 INFO - 'branch': 'Firefox', 17:03:00 INFO - 'buildbot_json_path': 'buildprops.json', 17:03:00 INFO - 'config_files': ('talos/mac_config.py',), 17:03:00 INFO - 'default_actions': ('clobber', 17:03:00 INFO - 'read-buildbot-config', 17:03:00 INFO - 'download-and-extract', 17:03:00 INFO - 'populate-webroot', 17:03:00 INFO - 'create-virtualenv', 17:03:00 INFO - 'install', 17:03:00 INFO - 'run-tests'), 17:03:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:03:00 INFO - 'download_minidump_stackwalk': True, 17:03:00 INFO - 'download_symbols': 'ondemand', 17:03:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:03:00 INFO - 'tooltool.py': '/tools/tooltool.py', 17:03:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:03:00 INFO - '/tools/misc-python/virtualenv.py')}, 17:03:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:03:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:03:00 INFO - 'gecko_profile': False, 17:03:00 INFO - 'gecko_profile_interval': 0, 17:03:00 INFO - 'installer_path': 'installer.exe', 17:03:00 INFO - 'log_level': 'info', 17:03:00 INFO - 'log_name': 'talos', 17:03:00 INFO - 'log_to_console': True, 17:03:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:03:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:03:00 INFO - 'opt_config_files': (), 17:03:00 INFO - 'pip_index': False, 17:03:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:03:00 INFO - 'cmd': ('bash', 17:03:00 INFO - '-c', 17:03:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:03:00 INFO - 'enabled': True, 17:03:00 INFO - 'halt_on_failure': False, 17:03:00 INFO - 'name': 'check_screen_resolution'},), 17:03:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:03:00 INFO - 'cmd': ('bash', 17:03:00 INFO - '-c', 17:03:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:03:00 INFO - 'enabled': True, 17:03:00 INFO - 'halt_on_failure': False, 17:03:00 INFO - 'name': 'check_screen_resolution'},), 17:03:00 INFO - 'run_cmd_checks_enabled': True, 17:03:00 INFO - 'suite': 'dromaeojs', 17:03:00 INFO - 'system_bits': '32', 17:03:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:03:00 INFO - 'title': 't-yosemite-r7-0305', 17:03:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:03:00 INFO - 'use_talos_json': True, 17:03:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:03:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:03:00 INFO - 'work_dir': 'build'} 17:03:00 INFO - [mozharness: 2017-04-29 00:03:00.172572Z] Running clobber step. 17:03:00 INFO - Running pre-action listener: _resource_record_pre_action 17:03:00 INFO - Running main action method: clobber 17:03:00 INFO - rmtree: /builds/slave/test/build 17:03:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:03:00 INFO - Running post-action listener: _resource_record_post_action 17:03:00 INFO - [mozharness: 2017-04-29 00:03:00.547022Z] Finished clobber step (success) 17:03:00 INFO - [mozharness: 2017-04-29 00:03:00.547153Z] Running read-buildbot-config step. 17:03:00 INFO - Running pre-action listener: _resource_record_pre_action 17:03:00 INFO - Running main action method: read_buildbot_config 17:03:00 INFO - Using buildbot properties: 17:03:00 INFO - { 17:03:00 INFO - "project": "", 17:03:00 INFO - "product": "firefox", 17:03:00 INFO - "script_repo_revision": "production", 17:03:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:03:00 INFO - "repository": "", 17:03:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:03:00 INFO - "buildid": "20170428170215", 17:03:00 INFO - "stage_platform": "macosx64", 17:03:00 INFO - "basedir": "/builds/slave/test", 17:03:00 INFO - "buildnumber": 14, 17:03:00 INFO - "platform": "yosemite_r7", 17:03:00 INFO - "mozci_request": { 17:03:00 INFO - "priority": 0, 17:03:00 INFO - "type": "trigger_all_talos_jobs", 17:03:00 INFO - "times": 6 17:03:00 INFO - }, 17:03:00 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:03:00 INFO - "slavebuilddir": "test", 17:03:00 INFO - "branch": "mozilla-central", 17:03:00 INFO - "revision": "b3b32894d9326d147238d9f071e1814ab3fdc850", 17:03:00 INFO - "slavename": "t-yosemite-r7-0305", 17:03:00 INFO - "builduid": "3c08f834763b4780be8fa3a566149442", 17:03:00 INFO - "repo_path": "mozilla-central" 17:03:00 INFO - } 17:03:00 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg. 17:03:00 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:03:00 INFO - Running post-action listener: _resource_record_post_action 17:03:00 INFO - [mozharness: 2017-04-29 00:03:00.551131Z] Finished read-buildbot-config step (success) 17:03:00 INFO - [mozharness: 2017-04-29 00:03:00.551246Z] Running download-and-extract step. 17:03:00 INFO - Running pre-action listener: _resource_record_pre_action 17:03:00 INFO - Running main action method: download_and_extract 17:03:00 INFO - mkdir: /builds/slave/test/build/tests 17:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:00 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json 17:03:00 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:03:00 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:03:00 INFO - Downloaded 1325 bytes. 17:03:00 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:03:00 INFO - Using the following test package requirements: 17:03:00 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:00 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:03:00 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:03:00 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:00 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:03:00 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:00 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:03:00 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:00 INFO - u'jsshell-mac.zip'], 17:03:00 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:00 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:03:00 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:03:00 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:00 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:03:00 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:00 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:03:00 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:00 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:03:00 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:00 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:03:00 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:03:00 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:03:00 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:03:00 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:03:02 INFO - Content-Length response header: 52698163 17:03:02 INFO - Bytes received: 52698163 17:03:18 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:03:18 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:03:18 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:03:18 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:03:19 INFO - Content-Length response header: 52698163 17:03:19 INFO - Bytes received: 52698163 17:03:34 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:03:34 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:03:34 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:03:35 INFO - Content-Length response header: 14408809 17:03:35 INFO - Bytes received: 14408809 17:03:35 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:03:35 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:03:35 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:03:35 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:03:37 INFO - Downloaded 71219323 bytes. 17:03:37 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:03:37 INFO - mkdir: /builds/slave/test/properties 17:03:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:03:37 INFO - Writing to file /builds/slave/test/properties/build_url 17:03:37 INFO - Contents: 17:03:37 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:03:37 INFO - Running post-action listener: _resource_record_post_action 17:03:37 INFO - Running post-action listener: set_extra_try_arguments 17:03:37 INFO - [mozharness: 2017-04-29 00:03:37.629204Z] Finished download-and-extract step (success) 17:03:37 INFO - [mozharness: 2017-04-29 00:03:37.629336Z] Running populate-webroot step. 17:03:37 INFO - Running pre-action listener: _resource_record_pre_action 17:03:37 INFO - Running main action method: populate_webroot 17:03:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:03:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:03:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:03:37 INFO - '--tppagecycles', 17:03:37 INFO - '7'], 17:03:37 INFO - 'tests': ['tsvgm']}}, 17:03:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:03:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:03:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:03:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:03:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:03:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:03:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:03:37 INFO - 'talos_options': ['--disable-e10s'], 17:03:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:03:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:03:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:03:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:03:37 INFO - 'talos_options': ['--disable-e10s'], 17:03:37 INFO - 'tests': ['damp', 'tps']}, 17:03:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:03:37 INFO - 'tests': ['damp', 'tps']}, 17:03:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:03:37 INFO - 'tests': ['dromaeo_dom']}, 17:03:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:03:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:03:37 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:03:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:03:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:03:37 INFO - 'tests': ['a11yr', 17:03:37 INFO - 'ts_paint', 17:03:37 INFO - 'tpaint', 17:03:37 INFO - 'sessionrestore', 17:03:37 INFO - 'sessionrestore_no_auto_restore', 17:03:37 INFO - 'tabpaint']}, 17:03:37 INFO - 'other-e10s': {'tests': ['a11yr', 17:03:37 INFO - 'ts_paint', 17:03:37 INFO - 'tpaint', 17:03:37 INFO - 'sessionrestore', 17:03:37 INFO - 'sessionrestore_no_auto_restore', 17:03:37 INFO - 'tabpaint']}, 17:03:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:03:37 INFO - 'ts_paint', 17:03:37 INFO - 'tpaint', 17:03:37 INFO - 'sessionrestore', 17:03:37 INFO - 'sessionrestore_no_auto_restore', 17:03:37 INFO - 'tabpaint']}, 17:03:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:03:37 INFO - 'ts_paint', 17:03:37 INFO - 'tpaint', 17:03:37 INFO - 'sessionrestore', 17:03:37 INFO - 'sessionrestore_no_auto_restore', 17:03:37 INFO - 'tabpaint']}, 17:03:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:03:37 INFO - 'tests': ['a11yr', 17:03:37 INFO - 'ts_paint', 17:03:37 INFO - 'tpaint', 17:03:37 INFO - 'sessionrestore', 17:03:37 INFO - 'sessionrestore_no_auto_restore', 17:03:37 INFO - 'tabpaint']}, 17:03:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:03:37 INFO - 'tests': ['a11yr', 17:03:37 INFO - 'ts_paint', 17:03:37 INFO - 'tpaint', 17:03:37 INFO - 'sessionrestore', 17:03:37 INFO - 'sessionrestore_no_auto_restore', 17:03:37 INFO - 'tabpaint']}, 17:03:37 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:03:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:03:37 INFO - 'bloom_basic_ref']}, 17:03:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:03:37 INFO - 'tests': ['tsvgx', 17:03:37 INFO - 'tsvgr_opacity', 17:03:37 INFO - 'tart', 17:03:37 INFO - 'tscrollx', 17:03:37 INFO - 'cart', 17:03:37 INFO - 'tsvg_static']}, 17:03:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:03:37 INFO - 'tsvgr_opacity', 17:03:37 INFO - 'tart', 17:03:37 INFO - 'tscrollx', 17:03:37 INFO - 'cart', 17:03:37 INFO - 'tsvg_static']}, 17:03:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:03:37 INFO - 'talos_options': ['--disable-e10s'], 17:03:37 INFO - 'tests': ['tp5o']}, 17:03:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:03:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:03:37 INFO - 'talos_options': ['--disable-e10s', 17:03:37 INFO - '--xperf_path', 17:03:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:03:37 INFO - 'tests': ['tp5n']}, 17:03:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:03:37 INFO - 'talos_options': ['--xperf_path', 17:03:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:03:37 INFO - 'tests': ['tp5n']}}, 17:03:37 INFO - 'talos.zip': {'path': '', 17:03:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:03:37 INFO - Running post-action listener: _resource_record_post_action 17:03:37 INFO - [mozharness: 2017-04-29 00:03:37.648933Z] Finished populate-webroot step (success) 17:03:37 INFO - [mozharness: 2017-04-29 00:03:37.649070Z] Running create-virtualenv step. 17:03:37 INFO - Running pre-action listener: _resource_record_pre_action 17:03:37 INFO - Running main action method: create_virtualenv 17:03:37 INFO - Creating virtualenv /builds/slave/test/build/venv 17:03:37 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:03:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:03:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:03:37 INFO - Using real prefix '/tools/python27' 17:03:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:03:38 INFO - Installing distribute.............................................................................................................................................................................................done. 17:03:41 INFO - Installing pip.................done. 17:03:41 INFO - Return code: 0 17:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:03:41 INFO - Reading from file tmpfile_stdout 17:03:41 INFO - Output received: 17:03:41 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:03:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:41 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 0x10ba8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21947b6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b869d30>, '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 0x10b78fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b85ebe8>, '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.YLAxq6BOr8/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.RCZDjInm1L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:03:41 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:03:41 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:03:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YLAxq6BOr8/Render', 17:03:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:41 INFO - 'HOME': '/Users/cltbld', 17:03:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:41 INFO - 'LOGNAME': 'cltbld', 17:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:41 INFO - 'MOZ_NO_REMOTE': '1', 17:03:41 INFO - 'NO_EM_RESTART': '1', 17:03:41 INFO - 'PAGER': '/bin/cat', 17:03:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:41 INFO - 'PWD': '/builds/slave/test', 17:03:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:41 INFO - 'SHELL': '/bin/bash', 17:03:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCZDjInm1L/Listeners', 17:03:41 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 17:03:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:41 INFO - 'USER': 'cltbld', 17:03:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:41 INFO - 'XPC_FLAGS': '0x0', 17:03:41 INFO - 'XPC_SERVICE_NAME': '0', 17:03:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:41 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:03:41 INFO - Cleaning up... 17:03:41 INFO - Return code: 0 17:03:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:41 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 0x10ba8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21947b6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b869d30>, '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 0x10b78fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b85ebe8>, '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.YLAxq6BOr8/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.RCZDjInm1L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:03:41 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:03:41 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:03:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YLAxq6BOr8/Render', 17:03:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:41 INFO - 'HOME': '/Users/cltbld', 17:03:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:41 INFO - 'LOGNAME': 'cltbld', 17:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:41 INFO - 'MOZ_NO_REMOTE': '1', 17:03:41 INFO - 'NO_EM_RESTART': '1', 17:03:41 INFO - 'PAGER': '/bin/cat', 17:03:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:41 INFO - 'PWD': '/builds/slave/test', 17:03:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:41 INFO - 'SHELL': '/bin/bash', 17:03:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCZDjInm1L/Listeners', 17:03:41 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 17:03:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:41 INFO - 'USER': 'cltbld', 17:03:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:41 INFO - 'XPC_FLAGS': '0x0', 17:03:41 INFO - 'XPC_SERVICE_NAME': '0', 17:03:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:42 INFO - Downloading/unpacking psutil>=3.1.1 17:03:42 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:03:42 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:03:42 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:03:42 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:03:42 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:03:42 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:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:03:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:46 INFO - Installing collected packages: psutil 17:03:46 INFO - Running setup.py install for psutil 17:03:46 INFO - building 'psutil._psutil_osx' extension 17:03:46 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:03:47 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:03:47 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:03:47 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:03:47 INFO - building 'psutil._psutil_posix' extension 17:03:47 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:03:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:03:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:03:47 INFO - ^ 17:03:47 INFO - 1 warning generated. 17:03:47 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:03:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:47 INFO - Successfully installed psutil 17:03:47 INFO - Cleaning up... 17:03:47 INFO - Return code: 0 17:03:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:47 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 0x10ba8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21947b6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b869d30>, '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 0x10b78fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b85ebe8>, '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.YLAxq6BOr8/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.RCZDjInm1L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:03:47 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:03:47 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:03:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YLAxq6BOr8/Render', 17:03:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:47 INFO - 'HOME': '/Users/cltbld', 17:03:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:47 INFO - 'LOGNAME': 'cltbld', 17:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:47 INFO - 'MOZ_NO_REMOTE': '1', 17:03:47 INFO - 'NO_EM_RESTART': '1', 17:03:47 INFO - 'PAGER': '/bin/cat', 17:03:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:47 INFO - 'PWD': '/builds/slave/test', 17:03:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:47 INFO - 'SHELL': '/bin/bash', 17:03:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCZDjInm1L/Listeners', 17:03:47 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 17:03:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:47 INFO - 'USER': 'cltbld', 17:03:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:47 INFO - 'XPC_FLAGS': '0x0', 17:03:47 INFO - 'XPC_SERVICE_NAME': '0', 17:03:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:03:47 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:03:47 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:03:47 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:03:47 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:03:47 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:03:47 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:03:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:03:50 INFO - Installing collected packages: mozsystemmonitor 17:03:50 INFO - Running setup.py install for mozsystemmonitor 17:03:50 INFO - Successfully installed mozsystemmonitor 17:03:50 INFO - Cleaning up... 17:03:50 INFO - Return code: 0 17:03:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:03:50 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:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:50 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:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:50 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 0x10ba8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21947b6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b869d30>, '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 0x10b78fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b85ebe8>, '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.YLAxq6BOr8/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.RCZDjInm1L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:03:50 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:03:50 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:03:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YLAxq6BOr8/Render', 17:03:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:50 INFO - 'HOME': '/Users/cltbld', 17:03:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:50 INFO - 'LOGNAME': 'cltbld', 17:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:50 INFO - 'MOZ_NO_REMOTE': '1', 17:03:50 INFO - 'NO_EM_RESTART': '1', 17:03:50 INFO - 'PAGER': '/bin/cat', 17:03:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:50 INFO - 'PWD': '/builds/slave/test', 17:03:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:50 INFO - 'SHELL': '/bin/bash', 17:03:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCZDjInm1L/Listeners', 17:03:50 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 17:03:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:50 INFO - 'USER': 'cltbld', 17:03:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:50 INFO - 'XPC_FLAGS': '0x0', 17:03:50 INFO - 'XPC_SERVICE_NAME': '0', 17:03:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:51 INFO - Downloading/unpacking jsonschema==2.5.1 17:03:51 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:03:51 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:03:51 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:03:51 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:03:51 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:03:51 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:03:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:03:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:03:53 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:03:53 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:03:53 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:03:53 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:03:53 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:03:53 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:03:53 INFO - Downloading functools32-3.2.3-2.tar.gz 17:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:03:54 INFO - warning: no files found matching '*.txt' 17:03:54 INFO - no previously-included directories found matching 'build' 17:03:54 INFO - no previously-included directories found matching 'dist' 17:03:54 INFO - no previously-included directories found matching '.git*' 17:03:54 INFO - Installing collected packages: jsonschema, functools32 17:03:54 INFO - Running setup.py install for functools32 17:03:54 INFO - warning: no files found matching '*.txt' 17:03:54 INFO - no previously-included directories found matching 'build' 17:03:54 INFO - no previously-included directories found matching 'dist' 17:03:54 INFO - no previously-included directories found matching '.git*' 17:03:54 INFO - Successfully installed jsonschema functools32 17:03:54 INFO - Cleaning up... 17:03:54 INFO - Return code: 0 17:03:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:03:54 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:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:55 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 0x10ba8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21947b6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b869d30>, '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 0x10b78fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b85ebe8>, '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.YLAxq6BOr8/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.RCZDjInm1L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:03:55 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:03:55 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:03:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YLAxq6BOr8/Render', 17:03:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:55 INFO - 'HOME': '/Users/cltbld', 17:03:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:55 INFO - 'LOGNAME': 'cltbld', 17:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:55 INFO - 'MOZ_NO_REMOTE': '1', 17:03:55 INFO - 'NO_EM_RESTART': '1', 17:03:55 INFO - 'PAGER': '/bin/cat', 17:03:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:55 INFO - 'PWD': '/builds/slave/test', 17:03:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:55 INFO - 'SHELL': '/bin/bash', 17:03:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCZDjInm1L/Listeners', 17:03:55 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 17:03:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:55 INFO - 'USER': 'cltbld', 17:03:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:55 INFO - 'XPC_FLAGS': '0x0', 17:03:55 INFO - 'XPC_SERVICE_NAME': '0', 17:03:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:03:55 INFO - Cleaning up... 17:03:55 INFO - Return code: 0 17:03:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:56 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 0x10ba8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21947b6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b869d30>, '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 0x10b78fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b85ebe8>, '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.YLAxq6BOr8/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.RCZDjInm1L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:03:56 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:03:56 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:03:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YLAxq6BOr8/Render', 17:03:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:56 INFO - 'HOME': '/Users/cltbld', 17:03:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:56 INFO - 'LOGNAME': 'cltbld', 17:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:56 INFO - 'MOZ_NO_REMOTE': '1', 17:03:56 INFO - 'NO_EM_RESTART': '1', 17:03:56 INFO - 'PAGER': '/bin/cat', 17:03:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:56 INFO - 'PWD': '/builds/slave/test', 17:03:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:56 INFO - 'SHELL': '/bin/bash', 17:03:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCZDjInm1L/Listeners', 17:03:56 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 17:03:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:56 INFO - 'USER': 'cltbld', 17:03:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:56 INFO - 'XPC_FLAGS': '0x0', 17:03:56 INFO - 'XPC_SERVICE_NAME': '0', 17:03:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:56 INFO - Downloading/unpacking blobuploader==1.2.4 17:03:56 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:03:56 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:03:56 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:03:56 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:03:56 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:03:56 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:03:58 INFO - Downloading blobuploader-1.2.4.tar.gz 17:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:03:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:03:59 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:03:59 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:03:59 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:03:59 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:03:59 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:03:59 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:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:03:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:03:59 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:03:59 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:03:59 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:03:59 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:03:59 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:03:59 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:04:00 INFO - Downloading docopt-0.6.1.tar.gz 17:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:00 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:00 INFO - Running setup.py install for blobuploader 17:04:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:04:00 INFO - Running setup.py install for requests 17:04:00 INFO - Running setup.py install for docopt 17:04:01 INFO - Successfully installed blobuploader requests docopt 17:04:01 INFO - Cleaning up... 17:04:01 INFO - Return code: 0 17:04:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:01 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 0x10ba8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21947b6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b869d30>, '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 0x10b78fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b85ebe8>, '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.YLAxq6BOr8/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.RCZDjInm1L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:04:01 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:04:01 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:04:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YLAxq6BOr8/Render', 17:04:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:01 INFO - 'HOME': '/Users/cltbld', 17:04:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:01 INFO - 'LOGNAME': 'cltbld', 17:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:01 INFO - 'MOZ_NO_REMOTE': '1', 17:04:01 INFO - 'NO_EM_RESTART': '1', 17:04:01 INFO - 'PAGER': '/bin/cat', 17:04:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:01 INFO - 'PWD': '/builds/slave/test', 17:04:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:01 INFO - 'SHELL': '/bin/bash', 17:04:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCZDjInm1L/Listeners', 17:04:01 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 17:04:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:01 INFO - 'USER': 'cltbld', 17:04:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:01 INFO - 'XPC_FLAGS': '0x0', 17:04:01 INFO - 'XPC_SERVICE_NAME': '0', 17:04:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:01 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-dPL7FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:01 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-cBmad5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:01 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-37yzvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:01 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-_TKMpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:01 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-GA4Eqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:01 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-ezgDr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:02 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-lTVhab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:02 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-MPzr2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:02 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-RaUAFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:02 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-LGpRq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:02 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-_Xq3OB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:02 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-tjAiZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:02 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-HuJOrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:02 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-ETd5zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:02 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-bnlk2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:03 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-y_uJ6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:03 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-dFLS2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:04:03 INFO - Running setup.py install for manifestparser 17:04:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:04:03 INFO - Running setup.py install for mozcrash 17:04:03 INFO - Running setup.py install for mozdebug 17:04:03 INFO - Running setup.py install for mozdevice 17:04:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:04:03 INFO - Running setup.py install for mozfile 17:04:03 INFO - Running setup.py install for mozhttpd 17:04:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:04:04 INFO - Running setup.py install for mozinfo 17:04:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:04:04 INFO - Running setup.py install for mozInstall 17:04:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:04:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:04:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:04:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:04:04 INFO - Running setup.py install for mozleak 17:04:04 INFO - Running setup.py install for mozlog 17:04:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:04:04 INFO - Running setup.py install for moznetwork 17:04:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:04:04 INFO - Running setup.py install for mozprocess 17:04:05 INFO - Running setup.py install for mozprofile 17:04:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:04:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:04:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:04:05 INFO - Running setup.py install for mozrunner 17:04:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:04:05 INFO - Running setup.py install for mozscreenshot 17:04:05 INFO - Running setup.py install for moztest 17:04:05 INFO - Running setup.py install for mozversion 17:04:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:04:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:04:05 INFO - Cleaning up... 17:04:05 INFO - Return code: 0 17:04:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04: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:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:05 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 0x10ba8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21947b6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b869d30>, '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 0x10b78fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b85ebe8>, '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.YLAxq6BOr8/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.RCZDjInm1L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:04:05 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:04:05 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:04:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YLAxq6BOr8/Render', 17:04:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:05 INFO - 'HOME': '/Users/cltbld', 17:04:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:05 INFO - 'LOGNAME': 'cltbld', 17:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:05 INFO - 'MOZ_NO_REMOTE': '1', 17:04:05 INFO - 'NO_EM_RESTART': '1', 17:04:05 INFO - 'PAGER': '/bin/cat', 17:04:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:05 INFO - 'PWD': '/builds/slave/test', 17:04:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:05 INFO - 'SHELL': '/bin/bash', 17:04:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCZDjInm1L/Listeners', 17:04:05 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 17:04:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:05 INFO - 'USER': 'cltbld', 17:04:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:05 INFO - 'XPC_FLAGS': '0x0', 17:04:05 INFO - 'XPC_SERVICE_NAME': '0', 17:04:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:06 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-tKxBhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:06 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-tW2fnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:06 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-sF0J_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:06 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-BLSvmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:06 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Qs0NG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:06 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-tNhioN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:06 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-ldka58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:06 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-JVceD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:06 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-w3Wkrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:07 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-UxWdud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:07 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-_F8LA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:07 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-D9x3qL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:07 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-0zsL7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:07 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-uwVvtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:07 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-iFp6O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:07 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-vs4esQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:07 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-zvJyOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:07 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:04:07 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:04:07 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:04:07 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:04:07 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:04:07 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:04:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:07 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:04:07 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:04:07 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:04:07 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:04:07 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:04:07 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:04:10 INFO - Downloading blessings-1.6.tar.gz 17:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:10 INFO - Installing collected packages: blessings 17:04:10 INFO - Running setup.py install for blessings 17:04:10 INFO - Successfully installed blessings 17:04:10 INFO - Cleaning up... 17:04:10 INFO - Return code: 0 17:04:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:04:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:11 INFO - Reading from file tmpfile_stdout 17:04:11 INFO - Current package versions: 17:04:11 INFO - blessings == 1.6 17:04:11 INFO - blobuploader == 1.2.4 17:04:11 INFO - docopt == 0.6.1 17:04:11 INFO - functools32 == 3.2.3-2 17:04:11 INFO - jsonschema == 2.5.1 17:04:11 INFO - manifestparser == 1.1 17:04:11 INFO - mozInstall == 1.12 17:04:11 INFO - mozcrash == 1.0 17:04:11 INFO - mozdebug == 0.1 17:04:11 INFO - mozdevice == 0.50 17:04:11 INFO - mozfile == 1.2 17:04:11 INFO - mozhttpd == 0.7 17:04:11 INFO - mozinfo == 0.9 17:04:11 INFO - mozleak == 0.1 17:04:11 INFO - mozlog == 3.4 17:04:11 INFO - moznetwork == 0.27 17:04:11 INFO - mozprocess == 0.25 17:04:11 INFO - mozprofile == 0.28 17:04:11 INFO - mozrunner == 6.13 17:04:11 INFO - mozscreenshot == 0.1 17:04:11 INFO - mozsystemmonitor == 0.3 17:04:11 INFO - moztest == 0.8 17:04:11 INFO - mozversion == 1.4 17:04:11 INFO - psutil == 3.1.1 17:04:11 INFO - requests == 1.2.3 17:04:11 INFO - wsgiref == 0.1.2 17:04:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:11 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:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:11 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:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:11 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 0x10ba8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21947b6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b869d30>, '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 0x10b78fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b85ebe8>, '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.YLAxq6BOr8/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.RCZDjInm1L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:04:11 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:04:11 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:04:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YLAxq6BOr8/Render', 17:04:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:11 INFO - 'HOME': '/Users/cltbld', 17:04:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:11 INFO - 'LOGNAME': 'cltbld', 17:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:11 INFO - 'MOZ_NO_REMOTE': '1', 17:04:11 INFO - 'NO_EM_RESTART': '1', 17:04:11 INFO - 'PAGER': '/bin/cat', 17:04:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:11 INFO - 'PWD': '/builds/slave/test', 17:04:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:11 INFO - 'SHELL': '/bin/bash', 17:04:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCZDjInm1L/Listeners', 17:04:11 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 17:04:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:11 INFO - 'USER': 'cltbld', 17:04:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:11 INFO - 'XPC_FLAGS': '0x0', 17:04:11 INFO - 'XPC_SERVICE_NAME': '0', 17:04:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 INFO - Cleaning up... 17:04:11 INFO - Return code: 0 17:04:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:04:11 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:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:11 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:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:11 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 0x10ba8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21947b6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b869d30>, '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 0x10b78fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b85ebe8>, '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.YLAxq6BOr8/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.RCZDjInm1L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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:04:11 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:04:11 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:04:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YLAxq6BOr8/Render', 17:04:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:11 INFO - 'HOME': '/Users/cltbld', 17:04:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:11 INFO - 'LOGNAME': 'cltbld', 17:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:11 INFO - 'MOZ_NO_REMOTE': '1', 17:04:11 INFO - 'NO_EM_RESTART': '1', 17:04:11 INFO - 'PAGER': '/bin/cat', 17:04:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:11 INFO - 'PWD': '/builds/slave/test', 17:04:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:11 INFO - 'SHELL': '/bin/bash', 17:04:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCZDjInm1L/Listeners', 17:04:11 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 17:04:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:11 INFO - 'USER': 'cltbld', 17:04:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:11 INFO - 'XPC_FLAGS': '0x0', 17:04:11 INFO - 'XPC_SERVICE_NAME': '0', 17:04:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:04:11 INFO - Cleaning up... 17:04:11 INFO - Return code: 0 17:04:11 INFO - Running post-action listener: _resource_record_post_action 17:04:11 INFO - Running post-action listener: _start_resource_monitoring 17:04:11 INFO - Starting resource monitoring. 17:04:11 INFO - [mozharness: 2017-04-29 00:04:11.703545Z] Finished create-virtualenv step (success) 17:04:11 INFO - [mozharness: 2017-04-29 00:04:11.704556Z] Running install step. 17:04:11 INFO - Running pre-action listener: _resource_record_pre_action 17:04:11 INFO - Running main action method: install 17:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:11 INFO - Reading from file tmpfile_stdout 17:04:11 INFO - Detecting whether we're running mozinstall >=1.0... 17:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:04:12 INFO - Reading from file tmpfile_stdout 17:04:12 INFO - Output received: 17:04:12 INFO - Usage: mozinstall [options] installer 17:04:12 INFO - Options: 17:04:12 INFO - -h, --help show this help message and exit 17:04:12 INFO - -d DEST, --destination=DEST 17:04:12 INFO - Directory to install application into. [default: 17:04:12 INFO - "/builds/slave/test"] 17:04:12 INFO - --app=APP Application being installed. [default: firefox] 17:04:12 INFO - mkdir: /builds/slave/test/build/application 17:04:12 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:04:12 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:04:31 INFO - Reading from file tmpfile_stdout 17:04:31 INFO - Output received: 17:04:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:04:31 INFO - Running post-action listener: _resource_record_post_action 17:04:31 INFO - [mozharness: 2017-04-29 00:04:31.923014Z] Finished install step (success) 17:04:31 INFO - [mozharness: 2017-04-29 00:04:31.923184Z] Running run-tests step. 17:04:31 INFO - Running pre-action listener: _resource_record_pre_action 17:04:31 INFO - Running main action method: run_tests 17:04:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:04:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:04:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:04:31 INFO - 2017-04-28 17:04:31.937 screenresolution[1986:19798] starting screenresolution argv=screenresolution get 17:04:31 INFO - 2017-04-28 17:04:31.940 screenresolution[1986:19798] Display 0: 1600x1200x32@60 17:04:31 INFO - 2017-04-28 17:04:31.945 screenresolution[1987:19801] starting screenresolution argv=screenresolution list 17:04:31 INFO - Available Modes on Display 0 17:04:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:04:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:04:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:04:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:04:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:04:32 INFO - Intel Iris: 17:04:32 INFO - Chipset Model: Intel Iris 17:04:32 INFO - Type: GPU 17:04:32 INFO - Bus: Built-In 17:04:32 INFO - VRAM (Dynamic, Max): 1536 MB 17:04:32 INFO - Vendor: Intel (0x8086) 17:04:32 INFO - Device ID: 0x0a2e 17:04:32 INFO - Revision ID: 0x0009 17:04:32 INFO - Displays: 17:04:32 INFO - Display: 17:04:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:04:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:04:32 INFO - Display Serial Number: 1600x1200 60 17:04:32 INFO - Main Display: Yes 17:04:32 INFO - Mirror: Off 17:04:32 INFO - Online: Yes 17:04:32 INFO - Rotation: Supported 17:04:32 INFO - Return code: 0 17:04:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:04:32 INFO - Python 2.7.3 17:04:32 INFO - Return code: 0 17:04:32 INFO - grabbing minidump binary from tooltool 17:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:32 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 0x10b869d30>, '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 0x10b78fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b85ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:04:32 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:04:32 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:04:32 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:04:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:04:32 INFO - Return code: 0 17:04:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:04:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:04:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:04:32 INFO - ENV: RUST_BACKTRACE is now 1 17:04:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:04:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:04:32 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-0305', '--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:04:32 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-0305 --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:04:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YLAxq6BOr8/Render', 17:04:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:32 INFO - 'HOME': '/Users/cltbld', 17:04:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:32 INFO - 'LOGNAME': 'cltbld', 17:04:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:04:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:32 INFO - 'MOZ_NO_REMOTE': '1', 17:04:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:04:32 INFO - 'NO_EM_RESTART': '1', 17:04:32 INFO - 'PAGER': '/bin/cat', 17:04:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:32 INFO - 'PWD': '/builds/slave/test', 17:04:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:04:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:32 INFO - 'RUST_BACKTRACE': '1', 17:04:32 INFO - 'SHELL': '/bin/bash', 17:04:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RCZDjInm1L/Listeners', 17:04:32 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 17:04:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:32 INFO - 'USER': 'cltbld', 17:04:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:32 INFO - 'XPC_FLAGS': '0x0', 17:04:32 INFO - 'XPC_SERVICE_NAME': '0', 17:04:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:32 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-0305', '--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:04:32 INFO - mozversion application_buildid: 20170428075320 17:04:32 INFO - mozversion application_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:04:32 INFO - mozversion application_display_name: Nightly 17:04:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:04:32 INFO - mozversion application_name: Firefox 17:04:32 INFO - mozversion application_remotingname: firefox 17:04:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:04:32 INFO - mozversion application_vendor: Mozilla 17:04:32 INFO - mozversion application_version: 55.0a1 17:04:32 INFO - mozversion platform_buildid: 20170428075320 17:04:32 INFO - mozversion platform_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:04:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:04:32 INFO - mozversion platform_version: 55.0a1 17:04:32 INFO - using testdate: 1493424272 17:04:32 INFO - actual date: 1493424272 17:04:32 INFO - starting webserver on 'localhost:49292' 17:04:32 INFO - SUITE-START | Running 2 tests 17:04:32 INFO - TEST-START | dromaeo_css 17:04:32 INFO - operating with platform_type : mac_ 17:04:32 INFO - Initialising browser for dromaeo_css test... 17:04:32 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpyG2uFO/profile http://localhost:49292/getInfo.html) 17:04:35 INFO - PID 1997 | __metrics Screen width/height:1600/1200 17:04:35 INFO - PID 1997 | colorDepth:24 17:04:35 INFO - PID 1997 | Browser inner width/height: 1024/689 17:04:35 INFO - PID 1997 | __metrics 17:04:35 INFO - PID 1997 | 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:04:35 INFO - PID 1997 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:04:36 INFO - TEST-INFO | 1997: exit 0 17:04:36 INFO - Browser initialized. 17:04:36 INFO - Running cycle 1/1 for dromaeo_css test... 17:04:36 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpyG2uFO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:48 INFO - PID 2000 | RSS: Main: 242331648 17:04:48 INFO - PID 2000 | 17:07:53 INFO - PID 2000 | Cycle 1(1): loaded http://localhost:49292/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49292/tests/dromaeo/cssquery-ext.html) 17:07:54 INFO - PID 2000 | RSS: Main: 393605120 17:07:54 INFO - PID 2000 | 17:09:37 INFO - PID 2000 | ************************* 17:09:37 INFO - PID 2000 | A coding exception was thrown and uncaught in a Task. 17:09:37 INFO - PID 2000 | 17:09:37 ERROR - PID 2000 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:09:37 INFO - PID 2000 | Full stack: 17:09:37 INFO - PID 2000 | ************************* 17:09:37 INFO - PID 2000 | ************************* 17:09:37 INFO - PID 2000 | A coding exception was thrown and uncaught in a Task. 17:09:37 INFO - PID 2000 | 17:09:37 ERROR - PID 2000 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:09:37 INFO - PID 2000 | Full stack: 17:09:37 INFO - PID 2000 | ************************* 17:09:37 INFO - PID 2000 | ************************* 17:09:37 INFO - PID 2000 | A coding exception was thrown and uncaught in a Task. 17:09:37 INFO - PID 2000 | 17:09:37 ERROR - PID 2000 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:09:37 INFO - PID 2000 | Full stack: 17:09:37 INFO - PID 2000 | ************************* 17:09:37 INFO - PID 2000 | ************************* 17:09:37 INFO - PID 2000 | A coding exception was thrown and uncaught in a Task. 17:09:37 INFO - PID 2000 | 17:09:37 ERROR - PID 2000 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:09:37 INFO - PID 2000 | Full stack: 17:09:37 INFO - PID 2000 | ************************* 17:10:57 INFO - PID 2000 | Cycle 1(1): loaded http://localhost:49292/tests/dromaeo/cssquery-ext.html (next: http://localhost:49292/tests/dromaeo/cssquery-jquery.html) 17:10:58 INFO - PID 2000 | RSS: Main: 371703808 17:10:58 INFO - PID 2000 | 17:14:00 INFO - PID 2000 | Cycle 1(1): loaded http://localhost:49292/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49292/tests/dromaeo/cssquery-mootools.html) 17:14:01 INFO - PID 2000 | RSS: Main: 329715712 17:14:01 INFO - PID 2000 | 17:17:03 INFO - PID 2000 | Cycle 1(1): loaded http://localhost:49292/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49292/tests/dromaeo/cssquery-prototype.html) 17:17:03 INFO - PID 2000 | RSS: Main: 360538112 17:17:03 INFO - PID 2000 | 17:20:07 INFO - PID 2000 | Cycle 1(1): loaded http://localhost:49292/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49292/tests/dromaeo/cssquery-yui.html) 17:20:07 INFO - PID 2000 | RSS: Main: 335462400 17:20:07 INFO - PID 2000 | 17:23:10 INFO - PID 2000 | Cycle 1(1): loaded http://localhost:49292/tests/dromaeo/cssquery-yui.html (next: http://localhost:49292/tests/dromaeo/cssquery-dojo.html) 17:23:10 INFO - PID 2000 | RSS: Main: 371589120 17:23:10 INFO - PID 2000 | 17:23:10 INFO - PID 2000 | __start_tp_report 17:23:10 INFO - PID 2000 | _x_x_mozilla_page_load 17:23:10 INFO - PID 2000 | _x_x_mozilla_page_load_details 17:23:10 INFO - PID 2000 | |i|pagename|runs| 17:23:10 INFO - PID 2000 | |0;dojo.html;3443.4662627292746;3469.1327168207945;3469.774464659797;3498.125468632841;3506.772059816112;5853.122031695248;5972.0444728843395;6085.634861908288;6095.085737139426;6105.023196288595;5857.179994800721;5886.058230683092;5903.734331955062;5916;5931.466168044875;5151.201563757605;5155.020546096239;5164.328637277149;5170.896582068356;5181.35233095863;5265.552428043621;5267.315249017623;5271.841844744664;5277.973610131944;5291.100512912795;5261.421243663194;5270;5271.341082364705;5272.762725677335;5274.997750427426;5248.212768084818;5263.210518422229;5278.524932756032;5284.788608455658;5294.814681486129;5097.6941383517105;5220;5226.216067589854;5248.527632513054;5256.579473642099;6080.695965201722;6129.509639228851;6131.724072416752;6170.629762214281;6190.628562286232;6343.527160561486;6351.015592583157;6380.840478988016;6398.872022559569;6403.7438502459845;4884.340614017097;6278.121063051177;6353.174087368659;6412.39082287182;6489.967550162219;6156.984097623842;6178.536609754242;6201.10084037812;6204.534659900481;6214.65819379934;6651.800445986628;6664.566803157779;6672.8999065013095;6682;6684.064231007663;6250.9062364064575;6268;6287.559870809091;6313.873722525615;6319.778807741707;6339.11252424661;6374.936250637435;6428.582142160744;6435.935640643534;6497.870042599122;6368.10846481493;6373.298937116913;6380.585261957958;6386.07401926718;6389.073584330246;6339.714712837934;6378.904316435257;6392.872142557216;6396.840078998062;6401.263854656681;5069.9746501267255;5126.564242039469;5126.820561280338;5131.922296317741;5133.4096578893905;4609.400777898919;4629.583337499641;4685.016146609182;4712.363830882856;4713.198756211452;6123;6155.138280640714;6176.320604733476;6178.783742569079;6182.28903676074;6462.159919210472;6462.709178086903;6464.191976003;6489.935100648933;6490.350964903472;5998.880022399528;6084.239470066242;6116.66358350295;6195.876082478415;6219.253689557282;5613.550915926798;5620.522255608237;5627;5631.493165615114;5644.294463192101;6489.091527186292;6536.803895883131;6539.50953678476;6553.4101930826455;6572.309907459744;5541.833744987657;6347.492200624031;6430.5177111715875;6445.1943507061615;6462.321456247214;6680.966595166993;6687.565308254948;6689.397954184147;6695.698693558704;6696.698648560729;6238.033104868752;6353.14232578596;6364.77723279683;6374.808755737336;6393;6292.244930608356;6356.618602883842;6424.550281480439;6461.224653041665;6466.127072845294;6282.057691346335;6290.905636415366;6302.243730752156;6315.989441689308;6335.3981371769605;6270.6551139685935;6273.654948977667;6319.115323854572;6320.367963203643;6328.6202827830475;5156;6100.520618786844;6118.847028824315;6204.937950620436;6247.062940558771;6269.435750782452;6297.433231009231;6300.936990630035;6304.968475157595;6307.400796924285;6249.093881387264;6249.312575616587;6254.937450625435;6263.373662633882;6270.717817698306 17:23:10 INFO - PID 2000 | |1;ext.html;791.647716766039;1113.649200501842;1129.3788416370994;1131.4908291268925;1228.4410593180105;35434.46848297274;36566.63433365666;36654.81672591637;36676.26647467049;36706.81646591763;36056.81971590145;36309.636903630955;36405.90782276529;36563.451548226796;36640.816795915984;6005.2193214882;6093.81718548442;7775.5723435211185;7917.802054948615;7937.126916039231;5994.760209591611;6070.21087258658;6075.817725468243;8291.17088291169;8476;8541.231289183972;8542.829143417128;8565.100664430238;8577.699780507683;8639.049704532496;8465.407421480499;8528.061913189544;8535.445196062266;8542.78643033929;8544.829103417958;5925.200097986803;5997.760089596411;8231.012278526556;8362.12197719243;8378.958105209496;36801.26397472063;36924.076898077765;36969.44545831814;37025.444618330745;37074;3564.9108772280642;3599.9100022499383;3604.1710406606367;3609.4405367168133;3610.0794297454245;30242;30268.394632107455;30296;30316;30402.087937361914;3073.738732207765;3138.2781960149296;3150.2596889730894;3167.0973772474963;3175.6824317568057;291540;297558;298531.50734246406;298739;298860;38309.616903831164;38424.23151536954;44470.777646111565;48077.75961120242;48390.75804620954;39244.60755392467;47633.047339053715;48055.55833325006;48063.75968120137;48159.75920120377;13484.190948543119;13591.864081359257;13595.320233988261;13610.795838062437;13611.455541778416;11101.333919964827;11103.722406939729;11122.61070862516;11147.554097836159;11152.888471115348;11618.360990145455;11675.182737208313;11711.648650540497;11717.765644687059;11759.706007349714;5232.3459567554055;5285.101532739443;5304.575633949275;5310.575153987749;5311.309529761106;931.0782325497709;1015.2588610314511;1018.6129270877019;1022.6318525330875;1052.2949623752104;21475.46311342229;22382.43322967409;22480;23792.762072379053;23960.64059039116;1119.7256672115384;1120.5573798349606;1152.815549512074;1163.20320580401;1180.2092597959388;11740.081723996766;12265.202761820454;12625.747485050431;15070.472533461276;15513.84486155124;245182;247982.76008619842;248755;249788;250501.49498505145;48910.266346004835;49081.75459122682;49171.016579668205;49316.75341623269;49470;1473.152937061194;1515.886308526865;1526.6030831983765;1532.8083989501313;1543.5986643472777;27595.724042759317;27805.165845024683;28378.716212837608;28454.004109856054;28457.28856778597;35321.11697207487;35343.82328088343;35407.46888796722;35476;35556;195739;233847;234164;235145;235584;27013;27188.45623087567;30161.396772063996;30689.158650481044;30727.539086914163;39858.60141398549;39912.00219994407;39969.2006159881;40024;40053.799731001156;27587.586186207624;28232;29925.85037074801;29950.850245748632;30190.698093019666;24522.50954980926;29200.707992919797;29998;30110.849445752632;30338.54492182575;33075.007749767545;36157;36267.63732362748;36352.90941271766;36492.81753591215;25410;28112.859435702692;30423.847880760455;30489.847550762104;30595.2351191222;18778.248870045045;22696.773032270128;23627.054917803096;23796.167134150222;23865 17:23:10 INFO - PID 2000 | |2;jquery.html;368.83402468889;413.4604341334559;422.08407755171277;434.86301814928305;447.51221168925883;19194.687835442714;20948.685769713447;21537.815420151885;21709.3487195384;21732;14697.92651036746;21611.243606473778;22222.222222222226;22326.776732232673;22407.551848963012;5853.50245229155;6146.108814221935;6146.139540464339;6149.354317796634;6161.722722477477;5254.763535640886;5842.269716285465;6026.06595977622;6040.48655864252;6094.146819445281;6007.8197654070445;6035.60768550045;6036.577439579231;6040.456358927696;6044.667543285118;5920.674362910038;6003.759849606011;6012.8496787580225;6056.545759068087;6072.301685306202;5242.2136679498;5377.838664840022;5383.865403364908;5390.083685773388;5395.298611180521;23717.7628223719;26924.73075269242;27431.17706468809;28267.717322826713;28497.287567810763;2189.5949249388914;2234.0170325057084;2242.5851217524646;2314.201600447843;2352.235523454867;18877.716834247498;18995.715064274045;19193.712094318595;19483.80516194834;19521.707174392395;1907.4945139538033;2285.5771682238837;2298.28753086542;2304.089884495615;2307.665388518672;161552;164846;165716;167252;167479.1626041874;21246.92616805635;21533.78466215349;23363.065477381053;23369.23653629889;23921.641175382385;40288.75524293681;40301.387944481896;40310.992225194015;40424.59575404267;40557.59442405597;8065.637046332812;8319.459235149696;8353.624086916103;8758;8817.735467935972;8417.158284171657;8582.914170858336;8628.870566941376;8727.854269222196;8745.212930836255;7752;7881.960590197127;7890.368770498347;7914.169012253746;7921.920780792234;2056.7737548869613;2192.8793916334753;2198.3844523533435;2217.423469897838;2218.5230175512343;942.9528523573931;956.1585804492003;958.1711819276416;973.4208146153028;996.2030375699411;20855;21388;21401.78598214029;21416.282978152205;21626.783732162792;929.4562680831789;948.9572969216264;989.4805227255605;1014.1379827146866;1028.8662473878499;10668.519916603771;10974.835377469344;11041.00630943219;11073.889261107446;11111.722206944729;511443;533132;544494.5550544444;544497;545617;112829.43585282021;119945.40027299982;120058;122314;124587.37706311411;1078.2829418436809;1091.2961140064615;1190.2144584574312;1232.3961258983034;1239.9938000309942;20351.861651672963;21533.353999380044;21687;21757;21809.345719627803;58924.70537647284;59364.70317648384;59790;59794.402055978884;60528.69735651294;79040;79829.01709829202;79854.60072699832;79879;82339.58830205811;8758.080401557745;8786.253168480494;8797.208251257418;8838.867416988878;9262.9810720822;14059.718805624036;14262.786058209344;14454.132752034911;14944.626384340478;15015.924920375328;10926.78146437051;11890;12050.276983381025;12120.636380908587;12309.322987235788;9549.570269337757;11447.599334023269;11533.308001519936;11576.90019448151;11933.985611223143;12274.815877761663;12285.69285767863;12491.312977785945;12527.31099789484;12531.624051278477;8719.78200544966;8838.690645827364;8866.601002954754;8867.778305542413;9206.355555111079;11576.768464630828;11772.293662380285;12113.33376664292;12157.513699452276;12191.756164876475 17:23:10 INFO - PID 2000 | |3;mootools.html;1250.4810503640986;1362.7666961399934;1410.569776218253;1422.2746399336336;1428.264443811438;10934.343939363644;10967.561297548098;11447.02700270477;11459.828102578467;11464.082873370142;11268.605598804044;11460.796616355288;11473.024792892615;11481.59814406496;11497.540098396075;2460.6678098456746;2500.6374075759004;2500.6874140732407;2501.0871032073255;2502.249325202432;1815.2285278756542;2075.149188832579;2331.114176612893;2386.72552656445;2395.8442701224367;2117.4282943605217;2409.6867407237037;2482.677251957252;2483.950320993579;2489.4896546207983;2431.817613678981;2446.620773780067;2454.7603460252635;2464.0759715106833;2467.5928471802313;2363.550925324183;2372.833901626887;2374.78626923576;2375.8218133639875;2378.394583656025;11150.665480035612;11417.086633069335;11421.657350279505;11427.314361138358;11441.599544015919;5350.694115830433;6401.487880969511;6553.836154096186;6593.637349945751;6602.1747281589805;3951.3480275754464;4102.261592913274;4215.325547912319;4235.195312890541;4245.893852653678;1227.226847086339;1231.8644949055597;1269.803180507023;1270.7013851744832;1272.8154417609394;13322.73354532904;16170.191490425432;16302.429414970538;16324.83675163245;16339.673206535921;5228.895422091537;5241;5425.6202065855805;5483.177523371526;5493.23094766733;11489.138314626436;11502.137339699557;11518.827217591743;11533.596324128783;11576.536938522364;6439.420452159235;6443.677816109176;6446.903296450557;6447.2907980122145;6454.128692626529;4926.802927882916;6069.878602427927;6132.356102609251;6170.969145154246;6233.2208473940755;4110.383442483651;4236.639885609696;4240.173166232555;4268.487781466244;4272.893177670583;1150.8273758936227;1239.4856134704178;1244.2783185752241;1259.8362212912264;1260.9936950315373;667.4893706314673;741.2957690194229;772.9652165652559;788.7791418402857;828.7928017995501;6086.573939824169;6095.8476038098515;6253.906191407133;6286.8428289292215;6326.272478665012;870.5603670146662;883.5273128876021;952.3952290295712;955.025873608915;957.7461972577133;4510.909781804346;4515.864524064284;4521.706089104197;4605.424321959755;4661.230896902041;14675.92662036683;14831.555053348417;14964.551063468114;14982.17598032097;14992.475263365948;14430;14782.408703651734;14882.851171488363;15000.474983375529;15047.548573542812;8347.4156809024;8574.442661227125;8584.8712269316;8597.226249637562;8604.8709269361;6049.1530888079815;6895.862082758417;7109;7115.181754098138;7165.426765858614;11811.93692567673;12443.813342800046;13307.866921330662;13322.400491978078;13365.26491042963;13263.336833158497;13453.730925381633;13474.79787803164;13750.518731844337;13817.723645526832;8898.688545900863;9165.358424910191;9290.860637090584;9293.535323233946;9297.535123243946;8827.293816494794;10631.94684026575;10639.095676867553;10642.73393165177;10656;8746.650133994823;8989.370744047854;9035.909640903506;9096.408733432305;9129.954350228207;8768.78078048054;8858.557072146237;8864.77838054028;8908.02011778691;8924.910750892668;8031.076426211061;8226.465279756796;8242.670293188205;8246.958765206136;8247.835043299221;5935.40645935403;5986.700664966647;6021.578489505692;6156.661383623944;6158.107074474266;5997.730102145327;6001.879962400641;6166.722497487714;6167.6916154193;6328.746850126127 17:23:10 INFO - PID 2000 | |4;prototype.html;332.7720710577967;377.2248030297737;396.5281315234869;398.9002749312671;402.43257007619246;5681.602287839853;5805.883882322351;5862.589618726691;5916.319623243334;5936.970315148424;4644;5552.972235138819;5666.660000399968;5723.2559767230205;5739.569532285074;4214.66282697385;4221;4225.873223803291;4231.217224813404;4239.2581298272835;4025.1949610077954;4189.7695626740515;4224.61978421942;4224.78876056196;4240.639545638624;3440.7591468597207;3614.8554057837655;4167.979160104195;4176.68674849386;4191.455110835603;4018.4374187613757;4200.6429453496185;4200.726952748061;4201.243776120282;4244.660427165819;3470.9305813883834;3605.4231322988194;3615.620359862203;3618.6924111450558;3633.400488919325;4536.705114167568;5510.531604813596;5544.528715059225;5581.302337207849;5626.381098079208;4914.599339188314;4938.987507560942;4946.455889852114;4957.454679985199;4971.950280497185;5634.014047541664;5885.911711324334;6001.459868611846;6045.879082418371;6053.424924632153;3792.412176112707;4082.8775136745944;4086.6934979876332;4091.9181616367805;4103.384492326145;5480.7533660985355;5717.599768016241;6210.347913469066;6432.646204458753;6518.706658200393;3416.538767266437;4079.7756123412905;4145.357469592158;4154.169166166779;4155.986909490595;3500.4049311617086;4200.177838167314;4208.664191373756;4220.978895105505;4225.619694227535;4138.482689663792;4790.233562629963;4900.583450406755;4937.136001199776;4939.086269040239;5717.914231286534;5771.874484475571;5790.652560846363;5802.4777770000055;6078.270607527036;1206.4691535724253;1414.9363278652486;1432.7850822376517;1434.390384086759;1435.411481292686;749.9762823745548;889.5196593839383;935.2284365398573;943.7640589852537;950.3680052764834;4708.858734237979;5298.70857102863;5773.653580785166;5808.564357673107;5817.331006934172;4801.159797035574;5560.777568897199;5611.961787069406;5938.8812223755285;6276.278228003746;4831.371921650163;5637.238972738628;5765.538756899438;5825.970870145622;5873.471387575053;3208.283568290953;3267.6895694908944;3286.802791832498;3300.966990330114;3308.1398836302255;5487.0246711183945;6329.68351582419;6423.4861211103;6509.144893705271;6602.339766023455;5644.8871022579315;6427.425280806232;6452.419032387083;6475.417212450902;6498.902516462257;5368.2752828367675;5942.3166335871065;6405.231372235362;6539.803805885831;6549.476041916635;6133.44798968095;6302.464290535356;6363.5227357947415;6365.904511432424;6370.713317900798;5921.703914804329;5948.791792287249;6281.466075383643;6292.52806039558;6292.968535157295;6163.811846794323;6371.87256254863;6526.9347306528225;6531.902021469777;6552.868942621216;4101.302778527717;4127.8968025799595;4128.442660240949;4140.23405669952;4147.91704165909;5568.2761241040025;6158.581986997259;6303.873922521616;6316.6841657916;6323.652199128908;5034.496550344937;6120.663363515049;6145;6146.262448506208;6170.7223174958135;5857.297124345106;6131.141640170469;6137.570370074231;6148.661823599745;6157.706881554924;5014.34813474246;6043.75824967014;6080.665563394055;6101.969490152521;6117.204763380732;5094.439611642791;6026.137584647257;6205.968970155121;6209.032773781048;6243.250809902841;5043.982407037214;5936.614120082181;5957.285125784933;6074.936886045013;6082.665453400105 17:23:10 INFO - PID 2000 | |5;yui.html;708.3377042465293;739.4343327354572;856.0155820806073;868.8653258744893;881.1805021330163;13039.152455090412;18043.729344059848;18215.998120103388;18764.53088672784;18812.623747525042;16932;16965.660686786287;17385.47843564692;17414.912925435354;17437.825621743777;935.6958988328803;952.7284723853703;959.4291396619035;960.0639376607821;960.1310813713566;675.3820254467157;677.0521270221705;681.3799442507319;693.0193775807227;1011.9797604047915;950.2635457520408;1024.2011231239608;1024.8667673202474;1026.7535791410046;1044.6030508406795;1015.4212099103514;1016.2733645443507;1016.4663551635376;1018.2363227579316;1054.9367037977709;448.74870072759035;521.6635270250667;752.7816933089398;761.6191904047976;783.2246076384396;12449.696806090811;12525.311107889154;12675.429605667674;13781.104228225133;16577.751333730004;16032.839671603251;16821.57946051346;17033.233504492327;17184.398546050827;17264.39574614895;11840.585579504675;14120.505782297672;14360;14392.92803535986;14403.423863045466;3358.0933148050135;3359.2777552826014;3365.1082463147286;3409.7272218222483;3417;112859;134213;134569;137637.36538442314;138817;9922.900770992343;11036.172287078502;12265.632031039084;12385.19496232742;12395.008399328031;19025.61948761017;19355.225790968485;24699.382515436897;24894.5021099577;24940.37649058788;7938.960305198437;7939.364850811921;7949;7949.284564389117;7954.761357159295;3923.5487918889694;3999.7400168988925;4004.5194576650406;4006.4791577094793;4009;3934.449177115206;4782.736949467812;4845.830395936126;4856.878578035577;4857.149998750205;928.0811996123789;970.1220395542045;970.8786351763724;973.3964941736027;973.6300205921705;637.9904301435482;658.5258613798153;664.0470924223658;668.2515582547578;683.9726410943606;10520.368777873353;11040.227184097197;11949.70125746846;12007.579734709418;12031;641.4099028893429;655.7180412422608;657.4444594317794;661.3783043938778;663.1478550063146;5332.493413125747;5450.836474905759;5913.645181289136;6019.789307374309;6040.969795150996;74478.13804654819;108036.63377225891;110465;111021;112167.3174902377;69985;98226;99998;100040;101936.49031754794;84356.57821710852;84533.57733211295;86777.26445471056;87548.56225718958;88320.5583972076;10109.747256318651;12285.201461904948;12363.32001739877;12372.505099795908;12614.936925315315;33679.810812297124;40439.97800110042;41014;41100.588994109676;41303.7934810324;57826.55433614193;72486;73235;73363.63318183375;73622.63188684237;15842.841571584599;16122.355105795637;16135.11256880836;16388;16478;17158.39945601898;17933.282668693628;18096.819031809515;18201.81798182001;18281;15688.215589220721;15879.920600396925;16509.17454127265;16611.252493638058;16676;14159.504417345755;15992.360305587647;17000.65998680044;17163.570910727332;17205.56986075358;14536.345864436338;15796.68406631838;16328.755068673741;16711;16773.66452670915;11620.825687614524;11665.00847427978;11742.647720568397;12106.939465302617;12409.069319801232;12180.390980451119;12799.552015679406;12799.87200128024;12800.10399272042;13092.345382730635 17:23:10 INFO - PID 2000 | __end_tp_report 17:23:10 INFO - PID 2000 | __start_cc_report 17:23:10 INFO - PID 2000 | _x_x_mozilla_cycle_collect,1787 17:23:10 INFO - PID 2000 | __end_cc_report 17:23:10 INFO - PID 2000 | __startTimestamp1493425390680__endTimestamp 17:23:10 INFO - PID 2000 | 17:23:10 INFO - PID 2000 | ------- Summary: start ------- 17:23:10 INFO - PID 2000 | Number of tests: 6 17:23:10 INFO - PID 2000 | 17:23:10 INFO - PID 2000 | [#0] dojo.html Cycles:165 Average:5940.57 Median:6247.06 stddev:686.54 (11.0%) stddev-sans-first:660.11 17:23:10 INFO - PID 2000 | Values: 3443.5 3469.1 3469.8 3498.1 3506.8 5853.1 5972.0 6085.6 6095.1 6105.0 5857.2 5886.1 5903.7 5916.0 5931.5 5151.2 5155.0 5164.3 5170.9 5181.4 5265.6 5267.3 5271.8 5278.0 5291.1 5261.4 5270.0 5271.3 5272.8 5275.0 5248.2 5263.2 5278.5 5284.8 5294.8 5097.7 5220.0 5226.2 5248.5 5256.6 6080.7 6129.5 6131.7 6170.6 6190.6 6343.5 6351.0 6380.8 6398.9 6403.7 4884.3 6278.1 6353.2 6412.4 6490.0 6157.0 6178.5 6201.1 6204.5 6214.7 6651.8 6664.6 6672.9 6682.0 6684.1 6250.9 6268.0 6287.6 6313.9 6319.8 6339.1 6374.9 6428.6 6435.9 6497.9 6368.1 6373.3 6380.6 6386.1 6389.1 6339.7 6378.9 6392.9 6396.8 6401.3 5070.0 5126.6 5126.8 5131.9 5133.4 4609.4 4629.6 4685.0 4712.4 4713.2 6123.0 6155.1 6176.3 6178.8 6182.3 6462.2 6462.7 6464.2 6489.9 6490.4 5998.9 6084.2 6116.7 6195.9 6219.3 5613.6 5620.5 5627.0 5631.5 5644.3 6489.1 6536.8 6539.5 6553.4 6572.3 5541.8 6347.5 6430.5 6445.2 6462.3 6681.0 6687.6 6689.4 6695.7 6696.7 6238.0 6353.1 6364.8 6374.8 6393.0 6292.2 6356.6 6424.6 6461.2 6466.1 6282.1 6290.9 6302.2 6316.0 6335.4 6270.7 6273.7 6319.1 6320.4 6328.6 5156.0 6100.5 6118.8 6204.9 6247.1 6269.4 6297.4 6300.9 6305.0 6307.4 6249.1 6249.3 6254.9 6263.4 6270.7 17:23:10 INFO - PID 2000 | 17:23:10 INFO - PID 2000 | [#1] ext.html Cycles:180 Average:40482.49 Median:30642.20 stddev:67774.61 (221.2%) stddev-sans-first:67899.21 17:23:10 INFO - PID 2000 | Values: 791.6 1113.6 1129.4 1131.5 1228.4 35434.5 36566.6 36654.8 36676.3 36706.8 36056.8 36309.6 36405.9 36563.5 36640.8 6005.2 6093.8 7775.6 7917.8 7937.1 5994.8 6070.2 6075.8 8291.2 8476.0 8541.2 8542.8 8565.1 8577.7 8639.0 8465.4 8528.1 8535.4 8542.8 8544.8 5925.2 5997.8 8231.0 8362.1 8379.0 36801.3 36924.1 36969.4 37025.4 37074.0 3564.9 3599.9 3604.2 3609.4 3610.1 30242.0 30268.4 30296.0 30316.0 30402.1 3073.7 3138.3 3150.3 3167.1 3175.7 291540.0 297558.0 298531.5 298739.0 298860.0 38309.6 38424.2 44470.8 48077.8 48390.8 39244.6 47633.0 48055.6 48063.8 48159.8 13484.2 13591.9 13595.3 13610.8 13611.5 11101.3 11103.7 11122.6 11147.6 11152.9 11618.4 11675.2 11711.6 11717.8 11759.7 5232.3 5285.1 5304.6 5310.6 5311.3 931.1 1015.3 1018.6 1022.6 1052.3 21475.5 22382.4 22480.0 23792.8 23960.6 1119.7 1120.6 1152.8 1163.2 1180.2 11740.1 12265.2 12625.7 15070.5 15513.8 245182.0 247982.8 248755.0 249788.0 250501.5 48910.3 49081.8 49171.0 49316.8 49470.0 1473.2 1515.9 1526.6 1532.8 1543.6 27595.7 27805.2 28378.7 28454.0 28457.3 35321.1 35343.8 35407.5 35476.0 35556.0 195739.0 233847.0 234164.0 235145.0 235584.0 27013.0 27188.5 30161.4 30689.2 30727.5 39858.6 39912.0 39969.2 40024.0 40053.8 27587.6 28232.0 29925.9 29950.9 30190.7 24522.5 29200.7 29998.0 30110.8 30338.5 33075.0 36157.0 36267.6 36352.9 36492.8 25410.0 28112.9 30423.8 30489.8 30595.2 18778.2 22696.8 23627.1 23796.2 23865.0 17:23:10 INFO - PID 2000 | 17:23:10 INFO - PID 2000 | [#2] jquery.html Cycles:180 Average:36388.06 Median:23819.70 stddev:91215.29 (382.9%) stddev-sans-first:91431.08 17:23:10 INFO - PID 2000 | Values: 368.8 413.5 422.1 434.9 447.5 19194.7 20948.7 21537.8 21709.3 21732.0 14697.9 21611.2 22222.2 22326.8 22407.6 5853.5 6146.1 6146.1 6149.4 6161.7 5254.8 5842.3 6026.1 6040.5 6094.1 6007.8 6035.6 6036.6 6040.5 6044.7 5920.7 6003.8 6012.8 6056.5 6072.3 5242.2 5377.8 5383.9 5390.1 5395.3 23717.8 26924.7 27431.2 28267.7 28497.3 2189.6 2234.0 2242.6 2314.2 2352.2 18877.7 18995.7 19193.7 19483.8 19521.7 1907.5 2285.6 2298.3 2304.1 2307.7 161552.0 164846.0 165716.0 167252.0 167479.2 21246.9 21533.8 23363.1 23369.2 23921.6 40288.8 40301.4 40311.0 40424.6 40557.6 8065.6 8319.5 8353.6 8758.0 8817.7 8417.2 8582.9 8628.9 8727.9 8745.2 7752.0 7882.0 7890.4 7914.2 7921.9 2056.8 2192.9 2198.4 2217.4 2218.5 943.0 956.2 958.2 973.4 996.2 20855.0 21388.0 21401.8 21416.3 21626.8 929.5 949.0 989.5 1014.1 1028.9 10668.5 10974.8 11041.0 11073.9 11111.7 511443.0 533132.0 544494.6 544497.0 545617.0 112829.4 119945.4 120058.0 122314.0 124587.4 1078.3 1091.3 1190.2 1232.4 1240.0 20351.9 21533.4 21687.0 21757.0 21809.3 58924.7 59364.7 59790.0 59794.4 60528.7 79040.0 79829.0 79854.6 79879.0 82339.6 8758.1 8786.3 8797.2 8838.9 9263.0 14059.7 14262.8 14454.1 14944.6 15015.9 10926.8 11890.0 12050.3 12120.6 12309.3 9549.6 11447.6 11533.3 11576.9 11934.0 12274.8 12285.7 12491.3 12527.3 12531.6 8719.8 8838.7 8866.6 8867.8 9206.4 11576.8 11772.3 12113.3 12157.5 12191.8 17:23:10 INFO - PID 2000 | 17:23:10 INFO - PID 2000 | [#3] mootools.html Cycles:180 Average:6976.70 Median:4106.32 stddev:4399.34 (107.1%) stddev-sans-first:4390.64 17:23:10 INFO - PID 2000 | Values: 1250.5 1362.8 1410.6 1422.3 1428.3 10934.3 10967.6 11447.0 11459.8 11464.1 11268.6 11460.8 11473.0 11481.6 11497.5 2460.7 2500.6 2500.7 2501.1 2502.2 1815.2 2075.1 2331.1 2386.7 2395.8 2117.4 2409.7 2482.7 2484.0 2489.5 2431.8 2446.6 2454.8 2464.1 2467.6 2363.6 2372.8 2374.8 2375.8 2378.4 11150.7 11417.1 11421.7 11427.3 11441.6 5350.7 6401.5 6553.8 6593.6 6602.2 3951.3 4102.3 4215.3 4235.2 4245.9 1227.2 1231.9 1269.8 1270.7 1272.8 13322.7 16170.2 16302.4 16324.8 16339.7 5228.9 5241.0 5425.6 5483.2 5493.2 11489.1 11502.1 11518.8 11533.6 11576.5 6439.4 6443.7 6446.9 6447.3 6454.1 4926.8 6069.9 6132.4 6171.0 6233.2 4110.4 4236.6 4240.2 4268.5 4272.9 1150.8 1239.5 1244.3 1259.8 1261.0 667.5 741.3 773.0 788.8 828.8 6086.6 6095.8 6253.9 6286.8 6326.3 870.6 883.5 952.4 955.0 957.7 4510.9 4515.9 4521.7 4605.4 4661.2 14675.9 14831.6 14964.6 14982.2 14992.5 14430.0 14782.4 14882.9 15000.5 15047.5 8347.4 8574.4 8584.9 8597.2 8604.9 6049.2 6895.9 7109.0 7115.2 7165.4 11811.9 12443.8 13307.9 13322.4 13365.3 13263.3 13453.7 13474.8 13750.5 13817.7 8898.7 9165.4 9290.9 9293.5 9297.5 8827.3 10631.9 10639.1 10642.7 10656.0 8746.7 8989.4 9035.9 9096.4 9130.0 8768.8 8858.6 8864.8 8908.0 8924.9 8031.1 8226.5 8242.7 8247.0 8247.8 5935.4 5986.7 6021.6 6156.7 6158.1 5997.7 6001.9 6166.7 6167.7 6328.7 17:23:10 INFO - PID 2000 | 17:23:10 INFO - PID 2000 | [#4] prototype.html Cycles:180 Average:4903.82 Median:5630.20 stddev:1547.10 (27.5%) stddev-sans-first:1512.92 17:23:10 INFO - PID 2000 | Values: 332.8 377.2 396.5 398.9 402.4 5681.6 5805.9 5862.6 5916.3 5937.0 4644.0 5553.0 5666.7 5723.3 5739.6 4214.7 4221.0 4225.9 4231.2 4239.3 4025.2 4189.8 4224.6 4224.8 4240.6 3440.8 3614.9 4168.0 4176.7 4191.5 4018.4 4200.6 4200.7 4201.2 4244.7 3470.9 3605.4 3615.6 3618.7 3633.4 4536.7 5510.5 5544.5 5581.3 5626.4 4914.6 4939.0 4946.5 4957.5 4972.0 5634.0 5885.9 6001.5 6045.9 6053.4 3792.4 4082.9 4086.7 4091.9 4103.4 5480.8 5717.6 6210.3 6432.6 6518.7 3416.5 4079.8 4145.4 4154.2 4156.0 3500.4 4200.2 4208.7 4221.0 4225.6 4138.5 4790.2 4900.6 4937.1 4939.1 5717.9 5771.9 5790.7 5802.5 6078.3 1206.5 1414.9 1432.8 1434.4 1435.4 750.0 889.5 935.2 943.8 950.4 4708.9 5298.7 5773.7 5808.6 5817.3 4801.2 5560.8 5612.0 5938.9 6276.3 4831.4 5637.2 5765.5 5826.0 5873.5 3208.3 3267.7 3286.8 3301.0 3308.1 5487.0 6329.7 6423.5 6509.1 6602.3 5644.9 6427.4 6452.4 6475.4 6498.9 5368.3 5942.3 6405.2 6539.8 6549.5 6133.4 6302.5 6363.5 6365.9 6370.7 5921.7 5948.8 6281.5 6292.5 6293.0 6163.8 6371.9 6526.9 6531.9 6552.9 4101.3 4127.9 4128.4 4140.2 4147.9 5568.3 6158.6 6303.9 6316.7 6323.7 5034.5 6120.7 6145.0 6146.3 6170.7 5857.3 6131.1 6137.6 6148.7 6157.7 5014.3 6043.8 6080.7 6102.0 6117.2 5094.4 6026.1 6206.0 6209.0 6243.3 5044.0 5936.6 5957.3 6074.9 6082.7 17:23:10 INFO - PID 2000 | 17:23:10 INFO - PID 2000 | [#5] yui.html Cycles:180 Average:22276.01 Median:18208.91 stddev:32324.55 (177.5%) stddev-sans-first:32374.66 17:23:10 INFO - PID 2000 | Values: 708.3 739.4 856.0 868.9 881.2 13039.2 18043.7 18216.0 18764.5 18812.6 16932.0 16965.7 17385.5 17414.9 17437.8 935.7 952.7 959.4 960.1 960.1 675.4 677.1 681.4 693.0 1012.0 950.3 1024.2 1024.9 1026.8 1044.6 1015.4 1016.3 1016.5 1018.2 1054.9 448.7 521.7 752.8 761.6 783.2 12449.7 12525.3 12675.4 13781.1 16577.8 16032.8 16821.6 17033.2 17184.4 17264.4 11840.6 14120.5 14360.0 14392.9 14403.4 3358.1 3359.3 3365.1 3409.7 3417.0 112859.0 134213.0 134569.0 137637.4 138817.0 9922.9 11036.2 12265.6 12385.2 12395.0 19025.6 19355.2 24699.4 24894.5 24940.4 7939.0 7939.4 7949.0 7949.3 7954.8 3923.5 3999.7 4004.5 4006.5 4009.0 3934.4 4782.7 4845.8 4856.9 4857.1 928.1 970.1 970.9 973.4 973.6 638.0 658.5 664.0 668.3 684.0 10520.4 11040.2 11949.7 12007.6 12031.0 641.4 655.7 657.4 661.4 663.1 5332.5 5450.8 5913.6 6019.8 6041.0 74478.1 108036.6 110465.0 111021.0 112167.3 69985.0 98226.0 99998.0 100040.0 101936.5 84356.6 84533.6 86777.3 87548.6 88320.6 10109.7 12285.2 12363.3 12372.5 12614.9 33679.8 40440.0 41014.0 41100.6 41303.8 57826.6 72486.0 73235.0 73363.6 73622.6 15842.8 16122.4 16135.1 16388.0 16478.0 17158.4 17933.3 18096.8 18201.8 18281.0 15688.2 15879.9 16509.2 16611.3 16676.0 14159.5 15992.4 17000.7 17163.6 17205.6 14536.3 15796.7 16328.8 16711.0 16773.7 11620.8 11665.0 11742.6 12106.9 12409.1 12180.4 12799.6 12799.9 12800.1 13092.3 17:23:10 INFO - PID 2000 | -------- Summary: end -------- 17:23:10 INFO - PID 2000 | 17:23:11 INFO - TEST-INFO | 2000: exit 0 17:23:11 INFO - TEST-OK | dromaeo_css | took 1118824ms 17:23:11 INFO - TEST-START | kraken 17:23:11 INFO - operating with platform_type : mac_ 17:23:11 INFO - Initialising browser for kraken test... 17:23:11 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmphAL41i/profile http://localhost:49292/getInfo.html) 17:23:13 INFO - PID 2005 | __metrics Screen width/height:1600/1200 17:23:13 INFO - PID 2005 | colorDepth:24 17:23:13 INFO - PID 2005 | Browser inner width/height: 1024/689 17:23:13 INFO - PID 2005 | __metrics 17:23:13 INFO - PID 2005 | 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:23:13 INFO - PID 2005 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:23:14 INFO - TEST-INFO | 2005: exit 0 17:23:14 INFO - Browser initialized. 17:23:14 INFO - Running cycle 1/1 for kraken test... 17:23:14 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmphAL41i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:27 INFO - PID 2006 | RSS: Main: 242511872 17:23:27 INFO - PID 2006 | 17:23:29 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49292/tests/kraken/driver.html?testName=audio-beat-detection) 17:23:30 INFO - PID 2006 | RSS: Main: 309772288 17:23:30 INFO - PID 2006 | 17:23:33 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49292/tests/kraken/driver.html?testName=audio-dft) 17:23:33 INFO - PID 2006 | RSS: Main: 291794944 17:23:33 INFO - PID 2006 | 17:23:37 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49292/tests/kraken/driver.html?testName=audio-fft) 17:23:38 INFO - PID 2006 | RSS: Main: 386363392 17:23:38 INFO - PID 2006 | 17:23:39 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49292/tests/kraken/driver.html?testName=audio-oscillator) 17:23:40 INFO - PID 2006 | RSS: Main: 290734080 17:23:40 INFO - PID 2006 | 17:23:42 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49292/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:23:43 INFO - PID 2006 | RSS: Main: 292564992 17:23:43 INFO - PID 2006 | 17:23:46 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49292/tests/kraken/driver.html?testName=imaging-darkroom) 17:23:46 INFO - PID 2006 | RSS: Main: 356085760 17:23:46 INFO - PID 2006 | 17:23:50 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49292/tests/kraken/driver.html?testName=imaging-desaturate) 17:23:50 INFO - PID 2006 | RSS: Main: 367804416 17:23:50 INFO - PID 2006 | 17:23:53 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49292/tests/kraken/driver.html?testName=json-parse-financial) 17:23:54 INFO - PID 2006 | RSS: Main: 351580160 17:23:54 INFO - PID 2006 | 17:23:55 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49292/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:23:56 INFO - PID 2006 | RSS: Main: 313585664 17:23:56 INFO - PID 2006 | 17:23:58 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49292/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:23:58 INFO - PID 2006 | RSS: Main: 334991360 17:23:58 INFO - PID 2006 | 17:24:00 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49292/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:24:01 INFO - PID 2006 | RSS: Main: 319512576 17:24:01 INFO - PID 2006 | 17:24:04 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:24:05 INFO - PID 2006 | RSS: Main: 353353728 17:24:05 INFO - PID 2006 | 17:24:08 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:24:09 INFO - PID 2006 | RSS: Main: 346341376 17:24:09 INFO - PID 2006 | 17:24:10 INFO - PID 2006 | Cycle 1(1): loaded http://localhost:49292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49292/tests/kraken/driver.html?testName=ai-astar) 17:24:11 INFO - PID 2006 | RSS: Main: 389046272 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | __start_tp_report 17:24:11 INFO - PID 2006 | _x_x_mozilla_page_load 17:24:11 INFO - PID 2006 | _x_x_mozilla_page_load_details 17:24:11 INFO - PID 2006 | |i|pagename|runs| 17:24:11 INFO - PID 2006 | |0;ai-astar;110;112;112;112;112;112;111;113;116;160 17:24:11 INFO - PID 2006 | |1;audio-beat-detection;141;108;101;158;109;115;141;89;145;140 17:24:11 INFO - PID 2006 | |2;audio-dft;190;255;220;186;185;182;187;185;181;185 17:24:11 INFO - PID 2006 | |3;audio-fft;80;62;58;89;57;57;58;57;83;59 17:24:11 INFO - PID 2006 | |4;audio-oscillator;99;70;87;69;69;68;91;68;68;97 17:24:11 INFO - PID 2006 | |5;imaging-gaussian-blur;92;136;78;121;135;87;88;89;89;93 17:24:11 INFO - PID 2006 | |6;imaging-darkroom;99;113;96;96;94;96;103;146;138;95 17:24:11 INFO - PID 2006 | |7;imaging-desaturate;86;88;105;137;86;83;83;87;86;84 17:24:11 INFO - PID 2006 | |8;json-parse-financial;51;49;48;49;48;49;48;48;50;48 17:24:11 INFO - PID 2006 | |9;json-stringify-tinderbox;59;53;64;62;60;56;57;56;56;58 17:24:11 INFO - PID 2006 | |10;stanford-crypto-aes;83;82;83;84;82;82;82;84;81;81 17:24:11 INFO - PID 2006 | |11;stanford-crypto-ccm;137;165;155;145;161;151;146;123;178;143 17:24:11 INFO - PID 2006 | |12;stanford-crypto-pbkdf2;194;247;200;189;193;189;190;193;190;185 17:24:11 INFO - PID 2006 | |13;stanford-crypto-sha256-iterative;68;69;70;69;73;62;64;73;94;94 17:24:11 INFO - PID 2006 | __end_tp_report 17:24:11 INFO - PID 2006 | __start_cc_report 17:24:11 INFO - PID 2006 | _x_x_mozilla_cycle_collect,2233 17:24:11 INFO - PID 2006 | __end_cc_report 17:24:11 INFO - PID 2006 | __startTimestamp1493425451216__endTimestamp 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | ------- Summary: start ------- 17:24:11 INFO - PID 2006 | Number of tests: 14 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#0] ai-astar Cycles:10 Average:117.00 Median:112.00 stddev:15.19 (13.6%) stddev-sans-first:15.90 17:24:11 INFO - PID 2006 | Values: 110.0 112.0 112.0 112.0 112.0 112.0 111.0 113.0 116.0 160.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#1] audio-beat-detection Cycles:10 Average:124.70 Median:141.00 stddev:22.95 (16.3%) stddev-sans-first:23.58 17:24:11 INFO - PID 2006 | Values: 141.0 108.0 101.0 158.0 109.0 115.0 141.0 89.0 145.0 140.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#2] audio-dft Cycles:10 Average:195.60 Median:186.50 stddev:23.70 (12.7%) stddev-sans-first:25.05 17:24:11 INFO - PID 2006 | Values: 190.0 255.0 220.0 186.0 185.0 182.0 187.0 185.0 181.0 185.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:12.69 (21.0%) stddev-sans-first:12.41 17:24:11 INFO - PID 2006 | Values: 80.0 62.0 58.0 89.0 57.0 57.0 58.0 57.0 83.0 59.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:78.50 stddev:13.23 (16.8%) stddev-sans-first:11.79 17:24:11 INFO - PID 2006 | Values: 99.0 70.0 87.0 69.0 69.0 68.0 91.0 68.0 68.0 97.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#5] imaging-gaussian-blur Cycles:10 Average:100.80 Median:88.50 stddev:21.36 (24.1%) stddev-sans-first:22.42 17:24:11 INFO - PID 2006 | Values: 92.0 136.0 78.0 121.0 135.0 87.0 88.0 89.0 89.0 93.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#6] imaging-darkroom Cycles:10 Average:107.60 Median:95.50 stddev:19.06 (20.0%) stddev-sans-first:19.96 17:24:11 INFO - PID 2006 | Values: 99.0 113.0 96.0 96.0 94.0 96.0 103.0 146.0 138.0 95.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#7] imaging-desaturate Cycles:10 Average:92.50 Median:86.00 stddev:16.89 (19.6%) stddev-sans-first:17.75 17:24:11 INFO - PID 2006 | Values: 86.0 88.0 105.0 137.0 86.0 83.0 83.0 87.0 86.0 84.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#8] json-parse-financial Cycles:10 Average:48.80 Median:49.00 stddev:1.03 (2.1%) stddev-sans-first:0.73 17:24:11 INFO - PID 2006 | Values: 51.0 49.0 48.0 49.0 48.0 49.0 48.0 48.0 50.0 48.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.50 stddev:3.25 (5.6%) stddev-sans-first:3.43 17:24:11 INFO - PID 2006 | Values: 59.0 53.0 64.0 62.0 60.0 56.0 57.0 56.0 56.0 58.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.07 (1.3%) stddev-sans-first:1.12 17:24:11 INFO - PID 2006 | Values: 83.0 82.0 83.0 84.0 82.0 82.0 82.0 84.0 81.0 81.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:153.00 stddev:15.43 (10.1%) stddev-sans-first:15.58 17:24:11 INFO - PID 2006 | Values: 137.0 165.0 155.0 145.0 161.0 151.0 146.0 123.0 178.0 143.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.00 Median:193.00 stddev:18.01 (9.3%) stddev-sans-first:19.07 17:24:11 INFO - PID 2006 | Values: 194.0 247.0 200.0 189.0 193.0 189.0 190.0 193.0 190.0 185.0 17:24:11 INFO - PID 2006 | 17:24:11 INFO - PID 2006 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:71.50 stddev:11.29 (15.8%) stddev-sans-first:11.79 17:24:11 INFO - PID 2006 | Values: 68.0 69.0 70.0 69.0 73.0 62.0 64.0 73.0 94.0 94.0 17:24:11 INFO - PID 2006 | -------- Summary: end -------- 17:24:11 INFO - PID 2006 | 17:24:12 INFO - TEST-INFO | 2006: exit 0 17:24:12 INFO - TEST-OK | kraken | took 61007ms 17:24:12 INFO - SUITE-END | took 1179s 17:24:12 INFO - Completed test suite (00:19:40) 17:24:12 INFO - javascript benchmark 17:24:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7685.119659123793, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3443.4662627292746, 3469.1327168207945, 3469.774464659797, 3498.125468632841, 3506.772059816112, 5853.122031695248, 5972.0444728843395, 6085.634861908288, 6095.085737139426, 6105.023196288595, 5857.179994800721, 5886.058230683092, 5903.734331955062, 5916.0, 5931.466168044875, 5151.201563757605, 5155.020546096239, 5164.328637277149, 5170.896582068356, 5181.35233095863, 5265.552428043621, 5267.315249017623, 5271.841844744664, 5277.973610131944, 5291.100512912795, 5261.421243663194, 5270.0, 5271.341082364705, 5272.762725677335, 5274.997750427426, 5248.212768084818, 5263.210518422229, 5278.524932756032, 5284.788608455658, 5294.814681486129, 5097.6941383517105, 5220.0, 5226.216067589854, 5248.527632513054, 5256.579473642099, 6080.695965201722, 6129.509639228851, 6131.724072416752, 6170.629762214281, 6190.628562286232, 6343.527160561486, 6351.015592583157, 6380.840478988016, 6398.872022559569, 6403.7438502459845, 4884.340614017097, 6278.121063051177, 6353.174087368659, 6412.39082287182, 6489.967550162219, 6156.984097623842, 6178.536609754242, 6201.10084037812, 6204.534659900481, 6214.65819379934, 6651.800445986628, 6664.566803157779, 6672.8999065013095, 6682.0, 6684.064231007663, 6250.9062364064575, 6268.0, 6287.559870809091, 6313.873722525615, 6319.778807741707, 6339.11252424661, 6374.936250637435, 6428.582142160744, 6435.935640643534, 6497.870042599122, 6368.10846481493, 6373.298937116913, 6380.585261957958, 6386.07401926718, 6389.073584330246, 6339.714712837934, 6378.904316435257, 6392.872142557216, 6396.840078998062, 6401.263854656681, 5069.9746501267255, 5126.564242039469, 5126.820561280338, 5131.922296317741, 5133.4096578893905, 4609.400777898919, 4629.583337499641, 4685.016146609182, 4712.363830882856, 4713.198756211452, 6123.0, 6155.138280640714, 6176.320604733476, 6178.783742569079, 6182.28903676074, 6462.159919210472, 6462.709178086903, 6464.191976003, 6489.935100648933, 6490.350964903472, 5998.880022399528, 6084.239470066242, 6116.66358350295, 6195.876082478415, 6219.253689557282, 5613.550915926798, 5620.522255608237, 5627.0, 5631.493165615114, 5644.294463192101, 6489.091527186292, 6536.803895883131, 6539.50953678476, 6553.4101930826455, 6572.309907459744, 5541.833744987657, 6347.492200624031, 6430.5177111715875, 6445.1943507061615, 6462.321456247214, 6680.966595166993, 6687.565308254948, 6689.397954184147, 6695.698693558704, 6696.698648560729, 6238.033104868752, 6353.14232578596, 6364.77723279683, 6374.808755737336, 6393.0, 6292.244930608356, 6356.618602883842, 6424.550281480439, 6461.224653041665, 6466.127072845294, 6282.057691346335, 6290.905636415366, 6302.243730752156, 6315.989441689308, 6335.3981371769605, 6270.6551139685935, 6273.654948977667, 6319.115323854572, 6320.367963203643, 6328.6202827830475, 5156.0, 6100.520618786844, 6118.847028824315, 6204.937950620436, 6247.062940558771, 6269.435750782452, 6297.433231009231, 6300.936990630035, 6304.968475157595, 6307.400796924285, 6249.093881387264, 6249.312575616587, 6254.937450625435, 6263.373662633882, 6270.717817698306], "value": 5895.899817191966, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.647716766039, 1113.649200501842, 1129.3788416370994, 1131.4908291268925, 1228.4410593180105, 35434.46848297274, 36566.63433365666, 36654.81672591637, 36676.26647467049, 36706.81646591763, 36056.81971590145, 36309.636903630955, 36405.90782276529, 36563.451548226796, 36640.816795915984, 6005.2193214882, 6093.81718548442, 7775.5723435211185, 7917.802054948615, 7937.126916039231, 5994.760209591611, 6070.21087258658, 6075.817725468243, 8291.17088291169, 8476.0, 8541.231289183972, 8542.829143417128, 8565.100664430238, 8577.699780507683, 8639.049704532496, 8465.407421480499, 8528.061913189544, 8535.445196062266, 8542.78643033929, 8544.829103417958, 5925.200097986803, 5997.760089596411, 8231.012278526556, 8362.12197719243, 8378.958105209496, 36801.26397472063, 36924.076898077765, 36969.44545831814, 37025.444618330745, 37074.0, 3564.9108772280642, 3599.9100022499383, 3604.1710406606367, 3609.4405367168133, 3610.0794297454245, 30242.0, 30268.394632107455, 30296.0, 30316.0, 30402.087937361914, 3073.738732207765, 3138.2781960149296, 3150.2596889730894, 3167.0973772474963, 3175.6824317568057, 291540.0, 297558.0, 298531.50734246406, 298739.0, 298860.0, 38309.616903831164, 38424.23151536954, 44470.777646111565, 48077.75961120242, 48390.75804620954, 39244.60755392467, 47633.047339053715, 48055.55833325006, 48063.75968120137, 48159.75920120377, 13484.190948543119, 13591.864081359257, 13595.320233988261, 13610.795838062437, 13611.455541778416, 11101.333919964827, 11103.722406939729, 11122.61070862516, 11147.554097836159, 11152.888471115348, 11618.360990145455, 11675.182737208313, 11711.648650540497, 11717.765644687059, 11759.706007349714, 5232.3459567554055, 5285.101532739443, 5304.575633949275, 5310.575153987749, 5311.309529761106, 931.0782325497709, 1015.2588610314511, 1018.6129270877019, 1022.6318525330875, 1052.2949623752104, 21475.46311342229, 22382.43322967409, 22480.0, 23792.762072379053, 23960.64059039116, 1119.7256672115384, 1120.5573798349606, 1152.815549512074, 1163.20320580401, 1180.2092597959388, 11740.081723996766, 12265.202761820454, 12625.747485050431, 15070.472533461276, 15513.84486155124, 245182.0, 247982.76008619842, 248755.0, 249788.0, 250501.49498505145, 48910.266346004835, 49081.75459122682, 49171.016579668205, 49316.75341623269, 49470.0, 1473.152937061194, 1515.886308526865, 1526.6030831983765, 1532.8083989501313, 1543.5986643472777, 27595.724042759317, 27805.165845024683, 28378.716212837608, 28454.004109856054, 28457.28856778597, 35321.11697207487, 35343.82328088343, 35407.46888796722, 35476.0, 35556.0, 195739.0, 233847.0, 234164.0, 235145.0, 235584.0, 27013.0, 27188.45623087567, 30161.396772063996, 30689.158650481044, 30727.539086914163, 39858.60141398549, 39912.00219994407, 39969.2006159881, 40024.0, 40053.799731001156, 27587.586186207624, 28232.0, 29925.85037074801, 29950.850245748632, 30190.698093019666, 24522.50954980926, 29200.707992919797, 29998.0, 30110.849445752632, 30338.54492182575, 33075.007749767545, 36157.0, 36267.63732362748, 36352.90941271766, 36492.81753591215, 25410.0, 28112.859435702692, 30423.847880760455, 30489.847550762104, 30595.2351191222, 18778.248870045045, 22696.773032270128, 23627.054917803096, 23796.167134150222, 23865.0], "value": 16647.07838523911, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.83402468889, 413.4604341334559, 422.08407755171277, 434.86301814928305, 447.51221168925883, 19194.687835442714, 20948.685769713447, 21537.815420151885, 21709.3487195384, 21732.0, 14697.92651036746, 21611.243606473778, 22222.222222222226, 22326.776732232673, 22407.551848963012, 5853.50245229155, 6146.108814221935, 6146.139540464339, 6149.354317796634, 6161.722722477477, 5254.763535640886, 5842.269716285465, 6026.06595977622, 6040.48655864252, 6094.146819445281, 6007.8197654070445, 6035.60768550045, 6036.577439579231, 6040.456358927696, 6044.667543285118, 5920.674362910038, 6003.759849606011, 6012.8496787580225, 6056.545759068087, 6072.301685306202, 5242.2136679498, 5377.838664840022, 5383.865403364908, 5390.083685773388, 5395.298611180521, 23717.7628223719, 26924.73075269242, 27431.17706468809, 28267.717322826713, 28497.287567810763, 2189.5949249388914, 2234.0170325057084, 2242.5851217524646, 2314.201600447843, 2352.235523454867, 18877.716834247498, 18995.715064274045, 19193.712094318595, 19483.80516194834, 19521.707174392395, 1907.4945139538033, 2285.5771682238837, 2298.28753086542, 2304.089884495615, 2307.665388518672, 161552.0, 164846.0, 165716.0, 167252.0, 167479.1626041874, 21246.92616805635, 21533.78466215349, 23363.065477381053, 23369.23653629889, 23921.641175382385, 40288.75524293681, 40301.387944481896, 40310.992225194015, 40424.59575404267, 40557.59442405597, 8065.637046332812, 8319.459235149696, 8353.624086916103, 8758.0, 8817.735467935972, 8417.158284171657, 8582.914170858336, 8628.870566941376, 8727.854269222196, 8745.212930836255, 7752.0, 7881.960590197127, 7890.368770498347, 7914.169012253746, 7921.920780792234, 2056.7737548869613, 2192.8793916334753, 2198.3844523533435, 2217.423469897838, 2218.5230175512343, 942.9528523573931, 956.1585804492003, 958.1711819276416, 973.4208146153028, 996.2030375699411, 20855.0, 21388.0, 21401.78598214029, 21416.282978152205, 21626.783732162792, 929.4562680831789, 948.9572969216264, 989.4805227255605, 1014.1379827146866, 1028.8662473878499, 10668.519916603771, 10974.835377469344, 11041.00630943219, 11073.889261107446, 11111.722206944729, 511443.0, 533132.0, 544494.5550544444, 544497.0, 545617.0, 112829.43585282021, 119945.40027299982, 120058.0, 122314.0, 124587.37706311411, 1078.2829418436809, 1091.2961140064615, 1190.2144584574312, 1232.3961258983034, 1239.9938000309942, 20351.861651672963, 21533.353999380044, 21687.0, 21757.0, 21809.345719627803, 58924.70537647284, 59364.70317648384, 59790.0, 59794.402055978884, 60528.69735651294, 79040.0, 79829.01709829202, 79854.60072699832, 79879.0, 82339.58830205811, 8758.080401557745, 8786.253168480494, 8797.208251257418, 8838.867416988878, 9262.9810720822, 14059.718805624036, 14262.786058209344, 14454.132752034911, 14944.626384340478, 15015.924920375328, 10926.78146437051, 11890.0, 12050.276983381025, 12120.636380908587, 12309.322987235788, 9549.570269337757, 11447.599334023269, 11533.308001519936, 11576.90019448151, 11933.985611223143, 12274.815877761663, 12285.69285767863, 12491.312977785945, 12527.31099789484, 12531.624051278477, 8719.78200544966, 8838.690645827364, 8866.601002954754, 8867.778305542413, 9206.355555111079, 11576.768464630828, 11772.293662380285, 12113.33376664292, 12157.513699452276, 12191.756164876475], "value": 10925.403682657987, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.4810503640986, 1362.7666961399934, 1410.569776218253, 1422.2746399336336, 1428.264443811438, 10934.343939363644, 10967.561297548098, 11447.02700270477, 11459.828102578467, 11464.082873370142, 11268.605598804044, 11460.796616355288, 11473.024792892615, 11481.59814406496, 11497.540098396075, 2460.6678098456746, 2500.6374075759004, 2500.6874140732407, 2501.0871032073255, 2502.249325202432, 1815.2285278756542, 2075.149188832579, 2331.114176612893, 2386.72552656445, 2395.8442701224367, 2117.4282943605217, 2409.6867407237037, 2482.677251957252, 2483.950320993579, 2489.4896546207983, 2431.817613678981, 2446.620773780067, 2454.7603460252635, 2464.0759715106833, 2467.5928471802313, 2363.550925324183, 2372.833901626887, 2374.78626923576, 2375.8218133639875, 2378.394583656025, 11150.665480035612, 11417.086633069335, 11421.657350279505, 11427.314361138358, 11441.599544015919, 5350.694115830433, 6401.487880969511, 6553.836154096186, 6593.637349945751, 6602.1747281589805, 3951.3480275754464, 4102.261592913274, 4215.325547912319, 4235.195312890541, 4245.893852653678, 1227.226847086339, 1231.8644949055597, 1269.803180507023, 1270.7013851744832, 1272.8154417609394, 13322.73354532904, 16170.191490425432, 16302.429414970538, 16324.83675163245, 16339.673206535921, 5228.895422091537, 5241.0, 5425.6202065855805, 5483.177523371526, 5493.23094766733, 11489.138314626436, 11502.137339699557, 11518.827217591743, 11533.596324128783, 11576.536938522364, 6439.420452159235, 6443.677816109176, 6446.903296450557, 6447.2907980122145, 6454.128692626529, 4926.802927882916, 6069.878602427927, 6132.356102609251, 6170.969145154246, 6233.2208473940755, 4110.383442483651, 4236.639885609696, 4240.173166232555, 4268.487781466244, 4272.893177670583, 1150.8273758936227, 1239.4856134704178, 1244.2783185752241, 1259.8362212912264, 1260.9936950315373, 667.4893706314673, 741.2957690194229, 772.9652165652559, 788.7791418402857, 828.7928017995501, 6086.573939824169, 6095.8476038098515, 6253.906191407133, 6286.8428289292215, 6326.272478665012, 870.5603670146662, 883.5273128876021, 952.3952290295712, 955.025873608915, 957.7461972577133, 4510.909781804346, 4515.864524064284, 4521.706089104197, 4605.424321959755, 4661.230896902041, 14675.92662036683, 14831.555053348417, 14964.551063468114, 14982.17598032097, 14992.475263365948, 14430.0, 14782.408703651734, 14882.851171488363, 15000.474983375529, 15047.548573542812, 8347.4156809024, 8574.442661227125, 8584.8712269316, 8597.226249637562, 8604.8709269361, 6049.1530888079815, 6895.862082758417, 7109.0, 7115.181754098138, 7165.426765858614, 11811.93692567673, 12443.813342800046, 13307.866921330662, 13322.400491978078, 13365.26491042963, 13263.336833158497, 13453.730925381633, 13474.79787803164, 13750.518731844337, 13817.723645526832, 8898.688545900863, 9165.358424910191, 9290.860637090584, 9293.535323233946, 9297.535123243946, 8827.293816494794, 10631.94684026575, 10639.095676867553, 10642.73393165177, 10656.0, 8746.650133994823, 8989.370744047854, 9035.909640903506, 9096.408733432305, 9129.954350228207, 8768.78078048054, 8858.557072146237, 8864.77838054028, 8908.02011778691, 8924.910750892668, 8031.076426211061, 8226.465279756796, 8242.670293188205, 8246.958765206136, 8247.835043299221, 5935.40645935403, 5986.700664966647, 6021.578489505692, 6156.661383623944, 6158.107074474266, 5997.730102145327, 6001.879962400641, 6166.722497487714, 6167.6916154193, 6328.746850126127], "value": 5275.581407047939, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.7720710577967, 377.2248030297737, 396.5281315234869, 398.9002749312671, 402.43257007619246, 5681.602287839853, 5805.883882322351, 5862.589618726691, 5916.319623243334, 5936.970315148424, 4644.0, 5552.972235138819, 5666.660000399968, 5723.2559767230205, 5739.569532285074, 4214.66282697385, 4221.0, 4225.873223803291, 4231.217224813404, 4239.2581298272835, 4025.1949610077954, 4189.7695626740515, 4224.61978421942, 4224.78876056196, 4240.639545638624, 3440.7591468597207, 3614.8554057837655, 4167.979160104195, 4176.68674849386, 4191.455110835603, 4018.4374187613757, 4200.6429453496185, 4200.726952748061, 4201.243776120282, 4244.660427165819, 3470.9305813883834, 3605.4231322988194, 3615.620359862203, 3618.6924111450558, 3633.400488919325, 4536.705114167568, 5510.531604813596, 5544.528715059225, 5581.302337207849, 5626.381098079208, 4914.599339188314, 4938.987507560942, 4946.455889852114, 4957.454679985199, 4971.950280497185, 5634.014047541664, 5885.911711324334, 6001.459868611846, 6045.879082418371, 6053.424924632153, 3792.412176112707, 4082.8775136745944, 4086.6934979876332, 4091.9181616367805, 4103.384492326145, 5480.7533660985355, 5717.599768016241, 6210.347913469066, 6432.646204458753, 6518.706658200393, 3416.538767266437, 4079.7756123412905, 4145.357469592158, 4154.169166166779, 4155.986909490595, 3500.4049311617086, 4200.177838167314, 4208.664191373756, 4220.978895105505, 4225.619694227535, 4138.482689663792, 4790.233562629963, 4900.583450406755, 4937.136001199776, 4939.086269040239, 5717.914231286534, 5771.874484475571, 5790.652560846363, 5802.4777770000055, 6078.270607527036, 1206.4691535724253, 1414.9363278652486, 1432.7850822376517, 1434.390384086759, 1435.411481292686, 749.9762823745548, 889.5196593839383, 935.2284365398573, 943.7640589852537, 950.3680052764834, 4708.858734237979, 5298.70857102863, 5773.653580785166, 5808.564357673107, 5817.331006934172, 4801.159797035574, 5560.777568897199, 5611.961787069406, 5938.8812223755285, 6276.278228003746, 4831.371921650163, 5637.238972738628, 5765.538756899438, 5825.970870145622, 5873.471387575053, 3208.283568290953, 3267.6895694908944, 3286.802791832498, 3300.966990330114, 3308.1398836302255, 5487.0246711183945, 6329.68351582419, 6423.4861211103, 6509.144893705271, 6602.339766023455, 5644.8871022579315, 6427.425280806232, 6452.419032387083, 6475.417212450902, 6498.902516462257, 5368.2752828367675, 5942.3166335871065, 6405.231372235362, 6539.803805885831, 6549.476041916635, 6133.44798968095, 6302.464290535356, 6363.5227357947415, 6365.904511432424, 6370.713317900798, 5921.703914804329, 5948.791792287249, 6281.466075383643, 6292.52806039558, 6292.968535157295, 6163.811846794323, 6371.87256254863, 6526.9347306528225, 6531.902021469777, 6552.868942621216, 4101.302778527717, 4127.8968025799595, 4128.442660240949, 4140.23405669952, 4147.91704165909, 5568.2761241040025, 6158.581986997259, 6303.873922521616, 6316.6841657916, 6323.652199128908, 5034.496550344937, 6120.663363515049, 6145.0, 6146.262448506208, 6170.7223174958135, 5857.297124345106, 6131.141640170469, 6137.570370074231, 6148.661823599745, 6157.706881554924, 5014.34813474246, 6043.75824967014, 6080.665563394055, 6101.969490152521, 6117.204763380732, 5094.439611642791, 6026.137584647257, 6205.968970155121, 6209.032773781048, 6243.250809902841, 5043.982407037214, 5936.614120082181, 5957.285125784933, 6074.936886045013, 6082.665453400105], "value": 4420.480901706479, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.3377042465293, 739.4343327354572, 856.0155820806073, 868.8653258744893, 881.1805021330163, 13039.152455090412, 18043.729344059848, 18215.998120103388, 18764.53088672784, 18812.623747525042, 16932.0, 16965.660686786287, 17385.47843564692, 17414.912925435354, 17437.825621743777, 935.6958988328803, 952.7284723853703, 959.4291396619035, 960.0639376607821, 960.1310813713566, 675.3820254467157, 677.0521270221705, 681.3799442507319, 693.0193775807227, 1011.9797604047915, 950.2635457520408, 1024.2011231239608, 1024.8667673202474, 1026.7535791410046, 1044.6030508406795, 1015.4212099103514, 1016.2733645443507, 1016.4663551635376, 1018.2363227579316, 1054.9367037977709, 448.74870072759035, 521.6635270250667, 752.7816933089398, 761.6191904047976, 783.2246076384396, 12449.696806090811, 12525.311107889154, 12675.429605667674, 13781.104228225133, 16577.751333730004, 16032.839671603251, 16821.57946051346, 17033.233504492327, 17184.398546050827, 17264.39574614895, 11840.585579504675, 14120.505782297672, 14360.0, 14392.92803535986, 14403.423863045466, 3358.0933148050135, 3359.2777552826014, 3365.1082463147286, 3409.7272218222483, 3417.0, 112859.0, 134213.0, 134569.0, 137637.36538442314, 138817.0, 9922.900770992343, 11036.172287078502, 12265.632031039084, 12385.19496232742, 12395.008399328031, 19025.61948761017, 19355.225790968485, 24699.382515436897, 24894.5021099577, 24940.37649058788, 7938.960305198437, 7939.364850811921, 7949.0, 7949.284564389117, 7954.761357159295, 3923.5487918889694, 3999.7400168988925, 4004.5194576650406, 4006.4791577094793, 4009.0, 3934.449177115206, 4782.736949467812, 4845.830395936126, 4856.878578035577, 4857.149998750205, 928.0811996123789, 970.1220395542045, 970.8786351763724, 973.3964941736027, 973.6300205921705, 637.9904301435482, 658.5258613798153, 664.0470924223658, 668.2515582547578, 683.9726410943606, 10520.368777873353, 11040.227184097197, 11949.70125746846, 12007.579734709418, 12031.0, 641.4099028893429, 655.7180412422608, 657.4444594317794, 661.3783043938778, 663.1478550063146, 5332.493413125747, 5450.836474905759, 5913.645181289136, 6019.789307374309, 6040.969795150996, 74478.13804654819, 108036.63377225891, 110465.0, 111021.0, 112167.3174902377, 69985.0, 98226.0, 99998.0, 100040.0, 101936.49031754794, 84356.57821710852, 84533.57733211295, 86777.26445471056, 87548.56225718958, 88320.5583972076, 10109.747256318651, 12285.201461904948, 12363.32001739877, 12372.505099795908, 12614.936925315315, 33679.810812297124, 40439.97800110042, 41014.0, 41100.588994109676, 41303.7934810324, 57826.55433614193, 72486.0, 73235.0, 73363.63318183375, 73622.63188684237, 15842.841571584599, 16122.355105795637, 16135.11256880836, 16388.0, 16478.0, 17158.39945601898, 17933.282668693628, 18096.819031809515, 18201.81798182001, 18281.0, 15688.215589220721, 15879.920600396925, 16509.17454127265, 16611.252493638058, 16676.0, 14159.504417345755, 15992.360305587647, 17000.65998680044, 17163.570910727332, 17205.56986075358, 14536.345864436338, 15796.68406631838, 16328.755068673741, 16711.0, 16773.66452670915, 11620.825687614524, 11665.00847427978, 11742.647720568397, 12106.939465302617, 12409.069319801232, 12180.390980451119, 12799.552015679406, 12799.87200128024, 12800.10399272042, 13092.345382730635], "value": 8237.674572742855, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1493.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 113.0, 116.0, 160.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 101.0, 158.0, 109.0, 115.0, 141.0, 89.0, 145.0, 140.0], "value": 124.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 255.0, 220.0, 186.0, 185.0, 182.0, 187.0, 185.0, 181.0, 185.0], "value": 195.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 62.0, 58.0, 89.0, 57.0, 57.0, 58.0, 57.0, 83.0, 59.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 70.0, 87.0, 69.0, 69.0, 68.0, 91.0, 68.0, 68.0, 97.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 136.0, 78.0, 121.0, 135.0, 87.0, 88.0, 89.0, 89.0, 93.0], "value": 100.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 113.0, 96.0, 96.0, 94.0, 96.0, 103.0, 146.0, 138.0, 95.0], "value": 107.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 105.0, 137.0, 86.0, 83.0, 83.0, 87.0, 86.0, 84.0], "value": 92.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 48.0, 49.0, 48.0, 49.0, 48.0, 48.0, 50.0, 48.0], "value": 48.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 53.0, 64.0, 62.0, 60.0, 56.0, 57.0, 56.0, 56.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 84.0, 82.0, 82.0, 82.0, 84.0, 81.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 165.0, 155.0, 145.0, 161.0, 151.0, 146.0, 123.0, 178.0, 143.0], "value": 150.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 247.0, 200.0, 189.0, 193.0, 189.0, 190.0, 193.0, 190.0, 185.0], "value": 197.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 69.0, 73.0, 62.0, 64.0, 73.0, 94.0, 94.0], "value": 73.6, "unit": "score"}]}]} 17:24:12 INFO - Return code: 0 17:24:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:24:12 ERROR - # TBPL SUCCESS # 17:24:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:24:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:24:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:24:12 INFO - 2017-04-28 17:24:12.991 screenresolution[2010:21963] starting screenresolution argv=screenresolution get 17:24:12 INFO - 2017-04-28 17:24:12.993 screenresolution[2010:21963] Display 0: 1600x1200x32@60 17:24:13 INFO - 2017-04-28 17:24:12.999 screenresolution[2011:21966] starting screenresolution argv=screenresolution list 17:24:13 INFO - Available Modes on Display 0 17:24:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:24:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:24:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:24:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:24:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:24:13 INFO - Intel Iris: 17:24:13 INFO - Chipset Model: Intel Iris 17:24:13 INFO - Type: GPU 17:24:13 INFO - Bus: Built-In 17:24:13 INFO - VRAM (Dynamic, Max): 1536 MB 17:24:13 INFO - Vendor: Intel (0x8086) 17:24:13 INFO - Device ID: 0x0a2e 17:24:13 INFO - Revision ID: 0x0009 17:24:13 INFO - Displays: 17:24:13 INFO - Display: 17:24:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:24:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:24:13 INFO - Display Serial Number: 1600x1200 60 17:24:13 INFO - Main Display: Yes 17:24:13 INFO - Mirror: Off 17:24:13 INFO - Online: Yes 17:24:13 INFO - Rotation: Supported 17:24:13 INFO - Return code: 0 17:24:13 INFO - Running post-action listener: _resource_record_post_action 17:24:13 INFO - [mozharness: 2017-04-29 00:24:13.240610Z] Finished run-tests step (success) 17:24:13 INFO - Running post-run listener: _resource_record_post_run 17:24:13 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 29199360; Write bytes: 511366144; Read time: 178; Write time: 1559 17:24:13 INFO - TinderboxPrint: CPU usage
53.3% 17:24:13 INFO - TinderboxPrint: I/O read bytes / time
29,199,360 / 178 17:24:13 INFO - TinderboxPrint: I/O write bytes / time
511,366,144 / 1,559 17:24:13 INFO - TinderboxPrint: CPU idle
2,246.1 (46.7%) 17:24:13 INFO - TinderboxPrint: CPU system
959.7 (20.0%) 17:24:13 INFO - TinderboxPrint: CPU user
1,600.0 (33.3%) 17:24:13 INFO - TinderboxPrint: Swap in / out
232,120,320 / 0 17:24:13 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208159232; Write bytes: 205498368; Read time: 15995; Write time: 414 17:24:13 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 28822528; Write bytes: 298613760; Read time: 173; Write time: 1113 17:24:13 INFO - Running post-run listener: _upload_blobber_files 17:24:13 INFO - Blob upload gear active. 17:24:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:24:13 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:24:13 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:24:13 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:24:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:24:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:24:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:24:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:15 INFO - (blobuploader) - INFO - Done attempting. 17:24:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:24:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:24:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:16 INFO - (blobuploader) - INFO - Done attempting. 17:24:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:24:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:24:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:17 INFO - (blobuploader) - INFO - Done attempting. 17:24:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:24:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:24:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:19 INFO - (blobuploader) - INFO - Done attempting. 17:24:19 INFO - (blobuploader) - INFO - Iteration through files over. 17:24:19 INFO - Return code: 0 17:24:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:24:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:24:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9af1ffb559765c68445e3c5cc3d614bad92d22d8fb23fc41bcd09eec32adf8f9e51376f8155a6cbb9a88968abded62fd46bdd0aa261579a8d0f27650fd11b7f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb9d56019da48a64a67e32add65f60a19d8ee559e6389f875992b52e79bc9f70badce0fdc0c2d749d1a8c79f7ef2cb5d75c5b62bf7c6212ff80ddffacda0517", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f789d6f2a7b704443cb9885fda463022f0ef6c977ebabdf9ed8d8f7bb57bb083ab17128e4ee7d9b487facc79c9f8af3c5bd7a7f1864abdf0c6ccba4c065d2188", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f384e0711fa52ea68c2795e93e001ed19d782760c4badf254959014591d8ebf41ade6fe763b265fae3416f65ef5a4b7bd3f043e8081014a7c2fcf274e24cbc5e"} 17:24:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:24:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:24:19 INFO - Contents: 17:24:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9af1ffb559765c68445e3c5cc3d614bad92d22d8fb23fc41bcd09eec32adf8f9e51376f8155a6cbb9a88968abded62fd46bdd0aa261579a8d0f27650fd11b7f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb9d56019da48a64a67e32add65f60a19d8ee559e6389f875992b52e79bc9f70badce0fdc0c2d749d1a8c79f7ef2cb5d75c5b62bf7c6212ff80ddffacda0517", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f789d6f2a7b704443cb9885fda463022f0ef6c977ebabdf9ed8d8f7bb57bb083ab17128e4ee7d9b487facc79c9f8af3c5bd7a7f1864abdf0c6ccba4c065d2188", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f384e0711fa52ea68c2795e93e001ed19d782760c4badf254959014591d8ebf41ade6fe763b265fae3416f65ef5a4b7bd3f043e8081014a7c2fcf274e24cbc5e"} 17:24:19 INFO - Running post-run listener: copy_logs_to_upload_dir 17:24:19 INFO - Copying logs to upload dir... 17:24:19 INFO - mkdir: /builds/slave/test/build/upload/logs 17:24:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.464110 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-28 17:24:19.522638) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:24:19.526258) ========= 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.YLAxq6BOr8/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.RCZDjInm1L/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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/9af1ffb559765c68445e3c5cc3d614bad92d22d8fb23fc41bcd09eec32adf8f9e51376f8155a6cbb9a88968abded62fd46bdd0aa261579a8d0f27650fd11b7f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb9d56019da48a64a67e32add65f60a19d8ee559e6389f875992b52e79bc9f70badce0fdc0c2d749d1a8c79f7ef2cb5d75c5b62bf7c6212ff80ddffacda0517", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f789d6f2a7b704443cb9885fda463022f0ef6c977ebabdf9ed8d8f7bb57bb083ab17128e4ee7d9b487facc79c9f8af3c5bd7a7f1864abdf0c6ccba4c065d2188", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f384e0711fa52ea68c2795e93e001ed19d782760c4badf254959014591d8ebf41ade6fe763b265fae3416f65ef5a4b7bd3f043e8081014a7c2fcf274e24cbc5e"} 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.011253 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/9af1ffb559765c68445e3c5cc3d614bad92d22d8fb23fc41bcd09eec32adf8f9e51376f8155a6cbb9a88968abded62fd46bdd0aa261579a8d0f27650fd11b7f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb9d56019da48a64a67e32add65f60a19d8ee559e6389f875992b52e79bc9f70badce0fdc0c2d749d1a8c79f7ef2cb5d75c5b62bf7c6212ff80ddffacda0517", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f789d6f2a7b704443cb9885fda463022f0ef6c977ebabdf9ed8d8f7bb57bb083ab17128e4ee7d9b487facc79c9f8af3c5bd7a7f1864abdf0c6ccba4c065d2188", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f384e0711fa52ea68c2795e93e001ed19d782760c4badf254959014591d8ebf41ade6fe763b265fae3416f65ef5a4b7bd3f043e8081014a7c2fcf274e24cbc5e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:24:19.562396) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:24:19.562796) ========= 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.YLAxq6BOr8/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.RCZDjInm1L/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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.005203 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:24:19.611682) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:24:19.612113) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:24:19.612456) ========= ========= Total master_lag: 0.25 =========