builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0373 starttime: 1489409235.9 results: success (0) buildid: 20170313054712 builduid: 9bbfd1ce5cb24dea9fc092d16642c474 revision: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 05:47:15.904012) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 05:47:15.904467) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 05:47:15.904746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 05:47:15.930491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 05:47:15.930874) ========= 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.h1L6zBv8WM/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.bsntF2ImYk/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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-03-13 05:47:15-- 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% 43.0M=0s 2017-03-13 05:47:16 (43.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118602 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 05:47:16.073058) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 05:47:16.073393) ========= 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.h1L6zBv8WM/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.bsntF2ImYk/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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.021142 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 05:47:16.122356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-13 05:47:16.122723) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd --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 fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h1L6zBv8WM/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.bsntF2ImYk/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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-03-13 05:47:16,211 truncating revision to first 12 chars 2017-03-13 05:47:16,211 Setting DEBUG logging. 2017-03-13 05:47:16,211 attempt 1/10 2017-03-13 05:47:16,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fc9f6f7e8e86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-13 05:47:17,324 unpacking tar archive at: mozilla-central-fc9f6f7e8e86/testing/mozharness/ program finished with exit code 0 elapsedTime=1.363577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-13 05:47:17.510904) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 05:47:17.511355) ========= script_repo_revision: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 05:47:17.511736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 05:47:17.512001) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 05:47:17.532973) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-13 05:47:17.533389) ========= /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.h1L6zBv8WM/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.bsntF2ImYk/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 05:47:17 INFO - MultiFileLogger online at 20170313 05:47:17 in /builds/slave/test 05:47:17 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 05:47:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:47:17 INFO - {'append_to_log': False, 05:47:17 INFO - 'base_work_dir': '/builds/slave/test', 05:47:17 INFO - 'blob_upload_branch': 'Firefox', 05:47:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:47:17 INFO - 'branch': 'Firefox', 05:47:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:47:17 INFO - 'config_files': ('talos/mac_config.py',), 05:47:17 INFO - 'default_actions': ('clobber', 05:47:17 INFO - 'read-buildbot-config', 05:47:17 INFO - 'download-and-extract', 05:47:17 INFO - 'populate-webroot', 05:47:17 INFO - 'create-virtualenv', 05:47:17 INFO - 'install', 05:47:17 INFO - 'run-tests'), 05:47:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:47:17 INFO - 'download_minidump_stackwalk': True, 05:47:17 INFO - 'download_symbols': 'ondemand', 05:47:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:47:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:47:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:47:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:47:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:47:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:47:17 INFO - 'installer_path': 'installer.exe', 05:47:17 INFO - 'log_level': 'info', 05:47:17 INFO - 'log_name': 'talos', 05:47:17 INFO - 'log_to_console': True, 05:47:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:47:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:47:17 INFO - 'opt_config_files': (), 05:47:17 INFO - 'pip_index': False, 05:47:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:47:17 INFO - 'cmd': ('bash', 05:47:17 INFO - '-c', 05:47:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:47:17 INFO - 'enabled': True, 05:47:17 INFO - 'halt_on_failure': False, 05:47:17 INFO - 'name': 'check_screen_resolution'},), 05:47:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:47:17 INFO - 'cmd': ('bash', 05:47:17 INFO - '-c', 05:47:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:47:17 INFO - 'enabled': True, 05:47:17 INFO - 'halt_on_failure': False, 05:47:17 INFO - 'name': 'check_screen_resolution'},), 05:47:17 INFO - 'run_cmd_checks_enabled': True, 05:47:17 INFO - 'sps_profile': False, 05:47:17 INFO - 'sps_profile_interval': 0, 05:47:17 INFO - 'suite': 'dromaeojs', 05:47:17 INFO - 'system_bits': '32', 05:47:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:47:17 INFO - 'title': 't-yosemite-r7-0373', 05:47:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:47:17 INFO - 'use_talos_json': True, 05:47:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:47:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:47:17 INFO - 'work_dir': 'build'} 05:47:17 INFO - [mozharness: 2017-03-13 12:47:17.740845Z] Running clobber step. 05:47:17 INFO - Running pre-action listener: _resource_record_pre_action 05:47:17 INFO - Running main action method: clobber 05:47:17 INFO - rmtree: /builds/slave/test/build 05:47:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:47:18 INFO - Running post-action listener: _resource_record_post_action 05:47:18 INFO - [mozharness: 2017-03-13 12:47:18.700841Z] Finished clobber step (success) 05:47:18 INFO - [mozharness: 2017-03-13 12:47:18.701005Z] Running read-buildbot-config step. 05:47:18 INFO - Running pre-action listener: _resource_record_pre_action 05:47:18 INFO - Running main action method: read_buildbot_config 05:47:18 INFO - Using buildbot properties: 05:47:18 INFO - { 05:47:18 INFO - "project": "", 05:47:18 INFO - "product": "firefox", 05:47:18 INFO - "script_repo_revision": "production", 05:47:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:47:18 INFO - "repository": "", 05:47:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:47:18 INFO - "buildid": "20170313054712", 05:47:18 INFO - "stage_platform": "macosx64", 05:47:18 INFO - "basedir": "/builds/slave/test", 05:47:18 INFO - "buildnumber": 20, 05:47:18 INFO - "platform": "yosemite_r7", 05:47:18 INFO - "mozci_request": { 05:47:18 INFO - "priority": -1, 05:47:18 INFO - "type": "trigger_all_talos_jobs", 05:47:18 INFO - "times": 1 05:47:18 INFO - }, 05:47:18 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:47:18 INFO - "slavebuilddir": "test", 05:47:18 INFO - "branch": "mozilla-central", 05:47:18 INFO - "revision": "fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd", 05:47:18 INFO - "slavename": "t-yosemite-r7-0373", 05:47:18 INFO - "builduid": "9bbfd1ce5cb24dea9fc092d16642c474", 05:47:18 INFO - "repo_path": "mozilla-central" 05:47:18 INFO - } 05:47:18 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg. 05:47:18 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json. 05:47:18 INFO - Running post-action listener: _resource_record_post_action 05:47:18 INFO - [mozharness: 2017-03-13 12:47:18.704851Z] Finished read-buildbot-config step (success) 05:47:18 INFO - [mozharness: 2017-03-13 12:47:18.704984Z] Running download-and-extract step. 05:47:18 INFO - Running pre-action listener: _resource_record_pre_action 05:47:18 INFO - Running main action method: download_and_extract 05:47:18 INFO - mkdir: /builds/slave/test/build/tests 05:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:18 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json 05:47:18 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 05:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 05:47:19 INFO - Downloaded 1199 bytes. 05:47:19 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 05:47:19 INFO - Using the following test package requirements: 05:47:19 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 05:47:19 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:47:19 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 05:47:19 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:47:19 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 05:47:19 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:47:19 INFO - u'jsshell-mac.zip'], 05:47:19 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:47:19 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 05:47:19 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 05:47:19 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:47:19 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 05:47:19 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:47:19 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 05:47:19 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:47:19 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 05:47:19 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:47:19 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 05:47:19 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:47:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip 05:47:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:47:19 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip into memory 05:47:20 INFO - Expected file size: 51504348 05:47:20 INFO - Obtained file size: 51504348 05:47:36 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:47:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip 05:47:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:47:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip into memory 05:47:37 INFO - Expected file size: 51504348 05:47:37 INFO - Obtained file size: 51504348 05:47:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.talos.tests.zip 05:47:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:47:52 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 05:47:53 INFO - Expected file size: 14403647 05:47:53 INFO - Obtained file size: 14403647 05:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:53 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 05:47:53 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 05:47:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 05:47:59 INFO - Downloaded 70417704 bytes. 05:47:59 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 05:47:59 INFO - mkdir: /builds/slave/test/properties 05:47:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:47:59 INFO - Writing to file /builds/slave/test/properties/build_url 05:47:59 INFO - Contents: 05:47:59 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 05:47:59 INFO - Running post-action listener: _resource_record_post_action 05:47:59 INFO - Running post-action listener: set_extra_try_arguments 05:47:59 INFO - [mozharness: 2017-03-13 12:47:59.828158Z] Finished download-and-extract step (success) 05:47:59 INFO - [mozharness: 2017-03-13 12:47:59.828263Z] Running populate-webroot step. 05:47:59 INFO - Running pre-action listener: _resource_record_pre_action 05:47:59 INFO - Running main action method: populate_webroot 05:47:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:47:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:47:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:47:59 INFO - '--tppagecycles', 05:47:59 INFO - '7'], 05:47:59 INFO - 'tests': ['tsvgm']}}, 05:47:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:47:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:47:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:47:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:47:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:47:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:47:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:47:59 INFO - 'talos_options': ['--disable-e10s'], 05:47:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:47:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:47:59 INFO - 'talos_options': ['--disable-e10s'], 05:47:59 INFO - 'tests': ['damp', 'tps']}, 05:47:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:47:59 INFO - 'tests': ['damp', 'tps']}, 05:47:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:47:59 INFO - 'tests': ['dromaeo_dom']}, 05:47:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:47:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:47:59 INFO - 'tests': ['basic_compositor_video']}, 05:47:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:47:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:47:59 INFO - 'tests': ['a11yr', 05:47:59 INFO - 'ts_paint', 05:47:59 INFO - 'tpaint', 05:47:59 INFO - 'sessionrestore', 05:47:59 INFO - 'sessionrestore_no_auto_restore', 05:47:59 INFO - 'tabpaint']}, 05:47:59 INFO - 'other-e10s': {'tests': ['a11yr', 05:47:59 INFO - 'ts_paint', 05:47:59 INFO - 'tpaint', 05:47:59 INFO - 'sessionrestore', 05:47:59 INFO - 'sessionrestore_no_auto_restore', 05:47:59 INFO - 'tabpaint']}, 05:47:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:47:59 INFO - 'ts_paint', 05:47:59 INFO - 'tpaint', 05:47:59 INFO - 'sessionrestore', 05:47:59 INFO - 'sessionrestore_no_auto_restore', 05:47:59 INFO - 'tabpaint']}, 05:47:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:47:59 INFO - 'ts_paint', 05:47:59 INFO - 'tpaint', 05:47:59 INFO - 'sessionrestore', 05:47:59 INFO - 'sessionrestore_no_auto_restore', 05:47:59 INFO - 'tabpaint']}, 05:47:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:47:59 INFO - 'tests': ['a11yr', 05:47:59 INFO - 'ts_paint', 05:47:59 INFO - 'tpaint', 05:47:59 INFO - 'sessionrestore', 05:47:59 INFO - 'sessionrestore_no_auto_restore', 05:47:59 INFO - 'tabpaint']}, 05:47:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:47:59 INFO - 'tests': ['a11yr', 05:47:59 INFO - 'ts_paint', 05:47:59 INFO - 'tpaint', 05:47:59 INFO - 'sessionrestore', 05:47:59 INFO - 'sessionrestore_no_auto_restore', 05:47:59 INFO - 'tabpaint']}, 05:47:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:47:59 INFO - 'tests': ['tsvgx', 05:47:59 INFO - 'tsvgr_opacity', 05:47:59 INFO - 'tart', 05:47:59 INFO - 'tscrollx', 05:47:59 INFO - 'cart', 05:47:59 INFO - 'tsvg_static']}, 05:47:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:47:59 INFO - 'tsvgr_opacity', 05:47:59 INFO - 'tart', 05:47:59 INFO - 'tscrollx', 05:47:59 INFO - 'cart', 05:47:59 INFO - 'tsvg_static']}, 05:47:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:47:59 INFO - 'talos_options': ['--disable-e10s'], 05:47:59 INFO - 'tests': ['tp5o']}, 05:47:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:47:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:47:59 INFO - 'talos_options': ['--disable-e10s', 05:47:59 INFO - '--xperf_path', 05:47:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:59 INFO - 'tests': ['tp5n']}, 05:47:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:47:59 INFO - 'talos_options': ['--xperf_path', 05:47:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:59 INFO - 'tests': ['tp5n']}}, 05:47:59 INFO - 'talos.zip': {'path': '', 05:47:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:47:59 INFO - Running post-action listener: _resource_record_post_action 05:47:59 INFO - [mozharness: 2017-03-13 12:47:59.844589Z] Finished populate-webroot step (success) 05:47:59 INFO - [mozharness: 2017-03-13 12:47:59.844740Z] Running create-virtualenv step. 05:47:59 INFO - Running pre-action listener: _resource_record_pre_action 05:47:59 INFO - Running main action method: create_virtualenv 05:47:59 INFO - Creating virtualenv /builds/slave/test/build/venv 05:47:59 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 05:47:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:47:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:47:59 INFO - Using real prefix '/tools/python27' 05:47:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:48:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:48:03 INFO - Installing pip.................done. 05:48:03 INFO - Return code: 0 05:48:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:48:03 INFO - Reading from file tmpfile_stdout 05:48:03 INFO - Output received: 05:48:03 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) 05:48:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:48:03 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')]} 05:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:03 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')]} 05:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:03 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 0x10afedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa892d673b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcbd30>, '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 0x10acf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10adc0be8>, '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.h1L6zBv8WM/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.bsntF2ImYk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 05:48:03 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 05:48:03 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 05:48:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1L6zBv8WM/Render', 05:48:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:03 INFO - 'HOME': '/Users/cltbld', 05:48:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:03 INFO - 'LOGNAME': 'cltbld', 05:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:03 INFO - 'MOZ_NO_REMOTE': '1', 05:48:03 INFO - 'NO_EM_RESTART': '1', 05:48:03 INFO - 'PAGER': '/bin/cat', 05:48:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:03 INFO - 'PWD': '/builds/slave/test', 05:48:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:03 INFO - 'SHELL': '/bin/bash', 05:48:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsntF2ImYk/Listeners', 05:48:03 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:48:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:03 INFO - 'USER': 'cltbld', 05:48:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:03 INFO - 'XPC_FLAGS': '0x0', 05:48:03 INFO - 'XPC_SERVICE_NAME': '0', 05:48:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:04 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 05:48:04 INFO - Cleaning up... 05:48:04 INFO - Return code: 0 05:48:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:48:04 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')]} 05:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:04 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')]} 05:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:04 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 0x10afedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa892d673b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcbd30>, '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 0x10acf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10adc0be8>, '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.h1L6zBv8WM/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.bsntF2ImYk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 05:48:04 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 05:48:04 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 05:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1L6zBv8WM/Render', 05:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:04 INFO - 'HOME': '/Users/cltbld', 05:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:04 INFO - 'LOGNAME': 'cltbld', 05:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:04 INFO - 'MOZ_NO_REMOTE': '1', 05:48:04 INFO - 'NO_EM_RESTART': '1', 05:48:04 INFO - 'PAGER': '/bin/cat', 05:48:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:04 INFO - 'PWD': '/builds/slave/test', 05:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:04 INFO - 'SHELL': '/bin/bash', 05:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsntF2ImYk/Listeners', 05:48:04 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:04 INFO - 'USER': 'cltbld', 05:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:04 INFO - 'XPC_FLAGS': '0x0', 05:48:04 INFO - 'XPC_SERVICE_NAME': '0', 05:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:04 INFO - Downloading/unpacking psutil>=3.1.1 05:48:04 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 05:48:04 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 05:48:04 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 05:48:04 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 05:48:04 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 05:48:04 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 05:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:48:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:07 INFO - Installing collected packages: psutil 05:48:07 INFO - Running setup.py install for psutil 05:48:07 INFO - building 'psutil._psutil_osx' extension 05:48:07 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 05:48:08 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 05:48:08 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 05:48:08 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 05:48:08 INFO - building 'psutil._psutil_posix' extension 05:48:08 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 05:48:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:48:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:48:08 INFO - ^ 05:48:08 INFO - 1 warning generated. 05:48:08 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 05:48:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:08 INFO - Successfully installed psutil 05:48:08 INFO - Cleaning up... 05:48:08 INFO - Return code: 0 05:48:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:48:08 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')]} 05:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:08 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')]} 05:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:08 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 0x10afedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa892d673b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcbd30>, '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 0x10acf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10adc0be8>, '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.h1L6zBv8WM/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.bsntF2ImYk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 05:48:08 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 05:48:08 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 05:48:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1L6zBv8WM/Render', 05:48:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:08 INFO - 'HOME': '/Users/cltbld', 05:48:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:08 INFO - 'LOGNAME': 'cltbld', 05:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:08 INFO - 'MOZ_NO_REMOTE': '1', 05:48:08 INFO - 'NO_EM_RESTART': '1', 05:48:08 INFO - 'PAGER': '/bin/cat', 05:48:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:08 INFO - 'PWD': '/builds/slave/test', 05:48:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:08 INFO - 'SHELL': '/bin/bash', 05:48:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsntF2ImYk/Listeners', 05:48:08 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:48:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:08 INFO - 'USER': 'cltbld', 05:48:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:08 INFO - 'XPC_FLAGS': '0x0', 05:48:08 INFO - 'XPC_SERVICE_NAME': '0', 05:48:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:48:08 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 05:48:08 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 05:48:08 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 05:48:08 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 05:48:08 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 05:48:08 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 05:48:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:48:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:48:11 INFO - Installing collected packages: mozsystemmonitor 05:48:11 INFO - Running setup.py install for mozsystemmonitor 05:48:11 INFO - Successfully installed mozsystemmonitor 05:48:11 INFO - Cleaning up... 05:48:11 INFO - Return code: 0 05:48:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:12 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')]} 05:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:12 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 0x10afedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa892d673b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcbd30>, '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 0x10acf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10adc0be8>, '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.h1L6zBv8WM/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.bsntF2ImYk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 05:48:12 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 05:48:12 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 05:48:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1L6zBv8WM/Render', 05:48:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:12 INFO - 'HOME': '/Users/cltbld', 05:48:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:12 INFO - 'LOGNAME': 'cltbld', 05:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:12 INFO - 'MOZ_NO_REMOTE': '1', 05:48:12 INFO - 'NO_EM_RESTART': '1', 05:48:12 INFO - 'PAGER': '/bin/cat', 05:48:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:12 INFO - 'PWD': '/builds/slave/test', 05:48:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:12 INFO - 'SHELL': '/bin/bash', 05:48:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsntF2ImYk/Listeners', 05:48:12 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:48:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:12 INFO - 'USER': 'cltbld', 05:48:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:12 INFO - 'XPC_FLAGS': '0x0', 05:48:12 INFO - 'XPC_SERVICE_NAME': '0', 05:48:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:12 INFO - Downloading/unpacking jsonschema==2.5.1 05:48:12 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 05:48:12 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 05:48:12 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 05:48:12 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 05:48:12 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 05:48:12 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 05:48:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:48:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:48:15 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 05:48:15 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 05:48:15 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 05:48:15 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 05:48:15 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 05:48:15 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 05:48:16 INFO - Downloading functools32-3.2.3-2.tar.gz 05:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:48:16 INFO - warning: no files found matching '*.txt' 05:48:16 INFO - no previously-included directories found matching 'build' 05:48:16 INFO - no previously-included directories found matching 'dist' 05:48:16 INFO - no previously-included directories found matching '.git*' 05:48:16 INFO - Installing collected packages: jsonschema, functools32 05:48:16 INFO - Running setup.py install for functools32 05:48:16 INFO - warning: no files found matching '*.txt' 05:48:16 INFO - no previously-included directories found matching 'build' 05:48:16 INFO - no previously-included directories found matching 'dist' 05:48:16 INFO - no previously-included directories found matching '.git*' 05:48:16 INFO - Successfully installed jsonschema functools32 05:48:16 INFO - Cleaning up... 05:48:16 INFO - Return code: 0 05:48:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10afedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa892d673b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcbd30>, '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 0x10acf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10adc0be8>, '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.h1L6zBv8WM/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.bsntF2ImYk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 05:48:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:48:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:48:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1L6zBv8WM/Render', 05:48:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:16 INFO - 'HOME': '/Users/cltbld', 05:48:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:16 INFO - 'LOGNAME': 'cltbld', 05:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:16 INFO - 'MOZ_NO_REMOTE': '1', 05:48:16 INFO - 'NO_EM_RESTART': '1', 05:48:16 INFO - 'PAGER': '/bin/cat', 05:48:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:16 INFO - 'PWD': '/builds/slave/test', 05:48:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:16 INFO - 'SHELL': '/bin/bash', 05:48:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsntF2ImYk/Listeners', 05:48:16 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:48:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:16 INFO - 'USER': 'cltbld', 05:48:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:16 INFO - 'XPC_FLAGS': '0x0', 05:48:16 INFO - 'XPC_SERVICE_NAME': '0', 05:48:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:48:17 INFO - Cleaning up... 05:48:17 INFO - Return code: 0 05:48:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10afedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa892d673b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcbd30>, '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 0x10acf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10adc0be8>, '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.h1L6zBv8WM/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.bsntF2ImYk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 05:48:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:48:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1L6zBv8WM/Render', 05:48:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:17 INFO - 'HOME': '/Users/cltbld', 05:48:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:17 INFO - 'LOGNAME': 'cltbld', 05:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:17 INFO - 'MOZ_NO_REMOTE': '1', 05:48:17 INFO - 'NO_EM_RESTART': '1', 05:48:17 INFO - 'PAGER': '/bin/cat', 05:48:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:17 INFO - 'PWD': '/builds/slave/test', 05:48:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:17 INFO - 'SHELL': '/bin/bash', 05:48:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsntF2ImYk/Listeners', 05:48:17 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:48:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:17 INFO - 'USER': 'cltbld', 05:48:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:17 INFO - 'XPC_FLAGS': '0x0', 05:48:17 INFO - 'XPC_SERVICE_NAME': '0', 05:48:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:17 INFO - Downloading/unpacking blobuploader==1.2.4 05:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:19 INFO - Downloading blobuploader-1.2.4.tar.gz 05:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:48:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:48:19 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 05:48:19 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 05:48:19 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 05:48:19 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 05:48:19 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 05:48:19 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 05:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:48:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:21 INFO - Downloading docopt-0.6.1.tar.gz 05:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:48:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:48:21 INFO - Running setup.py install for blobuploader 05:48:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:48:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:48:21 INFO - Running setup.py install for requests 05:48:21 INFO - Running setup.py install for docopt 05:48:22 INFO - Successfully installed blobuploader requests docopt 05:48:22 INFO - Cleaning up... 05:48:22 INFO - Return code: 0 05:48:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:22 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')]} 05:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:22 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')]} 05:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:22 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 0x10afedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa892d673b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcbd30>, '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 0x10acf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10adc0be8>, '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.h1L6zBv8WM/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.bsntF2ImYk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 05:48:22 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 05:48:22 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 05:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1L6zBv8WM/Render', 05:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:22 INFO - 'HOME': '/Users/cltbld', 05:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:22 INFO - 'LOGNAME': 'cltbld', 05:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:22 INFO - 'MOZ_NO_REMOTE': '1', 05:48:22 INFO - 'NO_EM_RESTART': '1', 05:48:22 INFO - 'PAGER': '/bin/cat', 05:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:22 INFO - 'PWD': '/builds/slave/test', 05:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:22 INFO - 'SHELL': '/bin/bash', 05:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsntF2ImYk/Listeners', 05:48:22 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:22 INFO - 'USER': 'cltbld', 05:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:22 INFO - 'XPC_FLAGS': '0x0', 05:48:22 INFO - 'XPC_SERVICE_NAME': '0', 05:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:22 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-KioJZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:22 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Z5m6MF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:22 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-LmgEeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:22 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Tkfozj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:22 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-73mt_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:22 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-pyMvZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-J_HyKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-RMSr4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-8n2min-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-IRiyVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-yWBbI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Qw0DZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-t3XVbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-ggccl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-lIHE0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:23 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-g3FPFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:24 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-gFyZMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:48:24 INFO - Running setup.py install for manifestparser 05:48:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:48:24 INFO - Running setup.py install for mozcrash 05:48:24 INFO - Running setup.py install for mozdebug 05:48:24 INFO - Running setup.py install for mozdevice 05:48:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:48:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:48:24 INFO - Running setup.py install for mozfile 05:48:24 INFO - Running setup.py install for mozhttpd 05:48:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:48:25 INFO - Running setup.py install for mozinfo 05:48:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:48:25 INFO - Running setup.py install for mozInstall 05:48:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:48:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:48:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:48:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:48:25 INFO - Running setup.py install for mozleak 05:48:25 INFO - Running setup.py install for mozlog 05:48:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:48:25 INFO - Running setup.py install for moznetwork 05:48:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:48:25 INFO - Running setup.py install for mozprocess 05:48:25 INFO - Running setup.py install for mozprofile 05:48:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:48:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:48:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:48:26 INFO - Running setup.py install for mozrunner 05:48:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:48:26 INFO - Running setup.py install for mozscreenshot 05:48:26 INFO - Running setup.py install for moztest 05:48:26 INFO - Running setup.py install for mozversion 05:48:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:48:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:48:26 INFO - Cleaning up... 05:48:26 INFO - Return code: 0 05:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:26 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')]} 05:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:26 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')]} 05:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:26 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 0x10afedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa892d673b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcbd30>, '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 0x10acf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10adc0be8>, '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.h1L6zBv8WM/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.bsntF2ImYk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 05:48:26 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 05:48:26 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 05:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1L6zBv8WM/Render', 05:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:26 INFO - 'HOME': '/Users/cltbld', 05:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:26 INFO - 'LOGNAME': 'cltbld', 05:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:26 INFO - 'MOZ_NO_REMOTE': '1', 05:48:26 INFO - 'NO_EM_RESTART': '1', 05:48:26 INFO - 'PAGER': '/bin/cat', 05:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:26 INFO - 'PWD': '/builds/slave/test', 05:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:26 INFO - 'SHELL': '/bin/bash', 05:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsntF2ImYk/Listeners', 05:48:26 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:26 INFO - 'USER': 'cltbld', 05:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:26 INFO - 'XPC_FLAGS': '0x0', 05:48:26 INFO - 'XPC_SERVICE_NAME': '0', 05:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:27 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-hJhgzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:27 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)) 05:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:27 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-cBEP_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:27 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)) 05:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:27 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-uO8g5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:27 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)) 05:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:27 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Ezt8ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:27 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-bjIit_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:27 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)) 05:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:27 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-oYtFvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:27 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)) 05:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:27 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-xkvI5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:27 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)) 05:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:27 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-C1gRCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:27 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)) 05:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:27 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-OBffUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:27 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)) 05:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:27 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-ab0DG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-0gHoqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-m6keq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-gWVNPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-dn43uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-r4zwHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-lA8hyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:28 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)) 05:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:28 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-WJ408c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:28 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)) 05:48:28 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)) 05:48:28 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)) 05:48:28 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)) 05:48:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:48:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:48:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:48:28 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 05:48:28 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 05:48:28 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 05:48:28 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 05:48:28 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 05:48:28 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 05:48:31 INFO - Downloading blessings-1.6.tar.gz 05:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:48:31 INFO - Installing collected packages: blessings 05:48:31 INFO - Running setup.py install for blessings 05:48:31 INFO - Successfully installed blessings 05:48:31 INFO - Cleaning up... 05:48:31 INFO - Return code: 0 05:48:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:48:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:32 INFO - Reading from file tmpfile_stdout 05:48:32 INFO - Current package versions: 05:48:32 INFO - blessings == 1.6 05:48:32 INFO - blobuploader == 1.2.4 05:48:32 INFO - docopt == 0.6.1 05:48:32 INFO - functools32 == 3.2.3-2 05:48:32 INFO - jsonschema == 2.5.1 05:48:32 INFO - manifestparser == 1.1 05:48:32 INFO - mozInstall == 1.12 05:48:32 INFO - mozcrash == 1.0 05:48:32 INFO - mozdebug == 0.1 05:48:32 INFO - mozdevice == 0.49 05:48:32 INFO - mozfile == 1.2 05:48:32 INFO - mozhttpd == 0.7 05:48:32 INFO - mozinfo == 0.9 05:48:32 INFO - mozleak == 0.1 05:48:32 INFO - mozlog == 3.4 05:48:32 INFO - moznetwork == 0.27 05:48:32 INFO - mozprocess == 0.24 05:48:32 INFO - mozprofile == 0.28 05:48:32 INFO - mozrunner == 6.13 05:48:32 INFO - mozscreenshot == 0.1 05:48:32 INFO - mozsystemmonitor == 0.3 05:48:32 INFO - moztest == 0.8 05:48:32 INFO - mozversion == 1.4 05:48:32 INFO - psutil == 3.1.1 05:48:32 INFO - requests == 1.2.3 05:48:32 INFO - wsgiref == 0.1.2 05:48:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:32 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 0x10afedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa892d673b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcbd30>, '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 0x10acf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10adc0be8>, '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.h1L6zBv8WM/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.bsntF2ImYk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 05:48:32 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 05:48:32 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 05:48:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1L6zBv8WM/Render', 05:48:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:32 INFO - 'HOME': '/Users/cltbld', 05:48:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:32 INFO - 'LOGNAME': 'cltbld', 05:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:32 INFO - 'MOZ_NO_REMOTE': '1', 05:48:32 INFO - 'NO_EM_RESTART': '1', 05:48:32 INFO - 'PAGER': '/bin/cat', 05:48:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:32 INFO - 'PWD': '/builds/slave/test', 05:48:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:32 INFO - 'SHELL': '/bin/bash', 05:48:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsntF2ImYk/Listeners', 05:48:32 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:48:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:32 INFO - 'USER': 'cltbld', 05:48:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:32 INFO - 'XPC_FLAGS': '0x0', 05:48:32 INFO - 'XPC_SERVICE_NAME': '0', 05:48:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 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)) 05:48:32 INFO - Cleaning up... 05:48:32 INFO - Return code: 0 05:48:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:32 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 0x10afedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aff0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa892d673b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcbd30>, '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 0x10acf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10adc0be8>, '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.h1L6zBv8WM/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.bsntF2ImYk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 05:48:32 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 05:48:32 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 05:48:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1L6zBv8WM/Render', 05:48:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:32 INFO - 'HOME': '/Users/cltbld', 05:48:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:32 INFO - 'LOGNAME': 'cltbld', 05:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:32 INFO - 'MOZ_NO_REMOTE': '1', 05:48:32 INFO - 'NO_EM_RESTART': '1', 05:48:32 INFO - 'PAGER': '/bin/cat', 05:48:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:32 INFO - 'PWD': '/builds/slave/test', 05:48:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:32 INFO - 'SHELL': '/bin/bash', 05:48:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsntF2ImYk/Listeners', 05:48:32 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:48:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:32 INFO - 'USER': 'cltbld', 05:48:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:32 INFO - 'XPC_FLAGS': '0x0', 05:48:32 INFO - 'XPC_SERVICE_NAME': '0', 05:48:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:48:32 INFO - Cleaning up... 05:48:32 INFO - Return code: 0 05:48:32 INFO - Running post-action listener: _resource_record_post_action 05:48:32 INFO - Running post-action listener: _start_resource_monitoring 05:48:32 INFO - Starting resource monitoring. 05:48:32 INFO - [mozharness: 2017-03-13 12:48:32.651033Z] Finished create-virtualenv step (success) 05:48:32 INFO - [mozharness: 2017-03-13 12:48:32.652057Z] Running install step. 05:48:32 INFO - Running pre-action listener: _resource_record_pre_action 05:48:32 INFO - Running main action method: install 05:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:32 INFO - Reading from file tmpfile_stdout 05:48:32 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:48:33 INFO - Reading from file tmpfile_stdout 05:48:33 INFO - Output received: 05:48:33 INFO - Usage: mozinstall [options] installer 05:48:33 INFO - Options: 05:48:33 INFO - -h, --help show this help message and exit 05:48:33 INFO - -d DEST, --destination=DEST 05:48:33 INFO - Directory to install application into. [default: 05:48:33 INFO - "/builds/slave/test"] 05:48:33 INFO - --app=APP Application being installed. [default: firefox] 05:48:33 INFO - mkdir: /builds/slave/test/build/application 05:48:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:48:56 INFO - Reading from file tmpfile_stdout 05:48:56 INFO - Output received: 05:48:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:48:56 INFO - Running post-action listener: _resource_record_post_action 05:48:56 INFO - [mozharness: 2017-03-13 12:48:56.073395Z] Finished install step (success) 05:48:56 INFO - [mozharness: 2017-03-13 12:48:56.073525Z] Running run-tests step. 05:48:56 INFO - Running pre-action listener: _resource_record_pre_action 05:48:56 INFO - Running main action method: run_tests 05:48:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:48:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:48:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:48:56 INFO - 2017-03-13 05:48:56.088 screenresolution[2855:33677] starting screenresolution argv=screenresolution get 05:48:56 INFO - 2017-03-13 05:48:56.091 screenresolution[2855:33677] Display 0: 1600x1200x32@60 05:48:56 INFO - 2017-03-13 05:48:56.097 screenresolution[2856:33679] starting screenresolution argv=screenresolution list 05:48:56 INFO - Available Modes on Display 0 05:48:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:48:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:48:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:48:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:48:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:48:56 INFO - Intel Iris: 05:48:56 INFO - Chipset Model: Intel Iris 05:48:56 INFO - Type: GPU 05:48:56 INFO - Bus: Built-In 05:48:56 INFO - VRAM (Dynamic, Max): 1536 MB 05:48:56 INFO - Vendor: Intel (0x8086) 05:48:56 INFO - Device ID: 0x0a2e 05:48:56 INFO - Revision ID: 0x0009 05:48:56 INFO - Displays: 05:48:56 INFO - Display: 05:48:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:48:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:48:56 INFO - Display Serial Number: 1600x1200 60 05:48:56 INFO - Main Display: Yes 05:48:56 INFO - Mirror: Off 05:48:56 INFO - Online: Yes 05:48:56 INFO - Rotation: Supported 05:48:56 INFO - Return code: 0 05:48:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:48:56 INFO - Python 2.7.3 05:48:56 INFO - Return code: 0 05:48:56 INFO - grabbing minidump binary from tooltool 05:48:56 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')]} 05:48:56 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 0x10adcbd30>, '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 0x10acf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10adc0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:48:56 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 05:48:56 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 05:48:56 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 05:48:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:48:56 INFO - Return code: 0 05:48:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:48:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:48:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:48:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:48:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:48:56 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/1487085285/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0373', '--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 05:48:56 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/1487085285/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0373 --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 05:48:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h1L6zBv8WM/Render', 05:48:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:48:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:48:56 INFO - 'HOME': '/Users/cltbld', 05:48:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:48:56 INFO - 'LOGNAME': 'cltbld', 05:48:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:48:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:56 INFO - 'MOZ_NO_REMOTE': '1', 05:48:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:48:56 INFO - 'NO_EM_RESTART': '1', 05:48:56 INFO - 'PAGER': '/bin/cat', 05:48:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:56 INFO - 'PWD': '/builds/slave/test', 05:48:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:48:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:48:56 INFO - 'SHELL': '/bin/bash', 05:48:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsntF2ImYk/Listeners', 05:48:56 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 05:48:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:48:56 INFO - 'USER': 'cltbld', 05:48:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:48:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:56 INFO - 'XPC_FLAGS': '0x0', 05:48:56 INFO - 'XPC_SERVICE_NAME': '0', 05:48:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:48:56 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/1487085285/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0373', '--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 05:48:56 INFO - mozversion application_buildid: 20170214071445 05:48:56 INFO - mozversion application_changeset: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd 05:48:56 INFO - mozversion application_display_name: Nightly 05:48:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:48:56 INFO - mozversion application_name: Firefox 05:48:56 INFO - mozversion application_remotingname: firefox 05:48:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:48:56 INFO - mozversion application_vendor: Mozilla 05:48:56 INFO - mozversion application_version: 54.0a1 05:48:56 INFO - mozversion platform_buildid: 20170214071445 05:48:56 INFO - mozversion platform_changeset: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd 05:48:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:48:56 INFO - mozversion platform_version: 54.0a1 05:48:56 INFO - using testdate: 1489409336 05:48:56 INFO - actual date: 1489409336 05:48:56 INFO - starting webserver on 'localhost:62751' 05:48:56 INFO - SUITE-START | Running 2 tests 05:48:56 INFO - TEST-START | dromaeo_css 05:48:56 INFO - operating with platform_type : mac_ 05:48:56 INFO - Initialising browser for dromaeo_css test... 05:48:56 INFO - TEST-INFO | started process 2866 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpMCQ_eN/profile http://localhost:62751/getInfo.html) 05:48:58 INFO - PROCESS | 2866 | __metrics Screen width/height:1600/1200 05:48:58 INFO - PROCESS | 2866 | colorDepth:24 05:48:58 INFO - PROCESS | 2866 | Browser inner width/height: 1024/689 05:48:58 INFO - PROCESS | 2866 | __metrics 05:48:59 INFO - PROCESS | 2866 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:48:59 INFO - PROCESS | 2866 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:48:59 INFO - TEST-INFO | 2866: exit 0 05:48:59 INFO - Browser initialized. 05:48:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:48:59 INFO - TEST-INFO | started process 2868 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpMCQ_eN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:11 INFO - PROCESS | 2868 | RSS: Main: 228577280 05:49:11 INFO - PROCESS | 2868 | 05:52:15 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:62751/tests/dromaeo/cssquery-dojo.html (next: http://localhost:62751/tests/dromaeo/cssquery-ext.html) 05:52:17 INFO - PROCESS | 2868 | RSS: Main: 398262272 05:52:17 INFO - PROCESS | 2868 | 05:54:01 INFO - PROCESS | 2868 | ************************* 05:54:01 INFO - PROCESS | 2868 | A coding exception was thrown and uncaught in a Task. 05:54:01 INFO - PROCESS | 2868 | 05:54:01 ERROR - PROCESS | 2868 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:54:01 INFO - PROCESS | 2868 | Full stack: 05:54:01 INFO - PROCESS | 2868 | ************************* 05:55:20 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:62751/tests/dromaeo/cssquery-ext.html (next: http://localhost:62751/tests/dromaeo/cssquery-jquery.html) 05:55:21 INFO - PROCESS | 2868 | RSS: Main: 372899840 05:55:21 INFO - PROCESS | 2868 | 05:58:24 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:62751/tests/dromaeo/cssquery-jquery.html (next: http://localhost:62751/tests/dromaeo/cssquery-mootools.html) 05:58:24 INFO - PROCESS | 2868 | RSS: Main: 351223808 05:58:24 INFO - PROCESS | 2868 | 06:01:27 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:62751/tests/dromaeo/cssquery-mootools.html (next: http://localhost:62751/tests/dromaeo/cssquery-prototype.html) 06:01:27 INFO - PROCESS | 2868 | RSS: Main: 335003648 06:01:27 INFO - PROCESS | 2868 | 06:04:30 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:62751/tests/dromaeo/cssquery-prototype.html (next: http://localhost:62751/tests/dromaeo/cssquery-yui.html) 06:04:31 INFO - PROCESS | 2868 | RSS: Main: 339378176 06:04:31 INFO - PROCESS | 2868 | 06:07:34 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:62751/tests/dromaeo/cssquery-yui.html (next: http://localhost:62751/tests/dromaeo/cssquery-dojo.html) 06:07:35 INFO - PROCESS | 2868 | RSS: Main: 456511488 06:07:35 INFO - PROCESS | 2868 | 06:07:35 INFO - PROCESS | 2868 | __start_tp_report 06:07:35 INFO - PROCESS | 2868 | _x_x_mozilla_page_load 06:07:35 INFO - PROCESS | 2868 | _x_x_mozilla_page_load_details 06:07:35 INFO - PROCESS | 2868 | |i|pagename|runs| 06:07:35 INFO - PROCESS | 2868 | |0;dojo.html;2673.9866300668496;3212.807231566106;3240.5463235147067;3241.319322942182;3257.0554539183636;5280.128778751511;5406.405295417501;5454.427285135063;5502.339719233692;5511.035568775464;5416.539594134503;5423.996560636285;5425.430329815362;5429.56563474922;5429.972850135754;4950.752462376885;4965.528274813887;4995.525425084629;5046.798128074873;5076.974615126937;4972.651914365996;5080.822171224008;5083.822066227683;5086.237064440326;5095.541401273885;5068.366454193226;5073.0361231366105;5076.984603079399;5078.949210507884;5080.720560369178;5061.519155680223;5075.543201111917;5077.136886729247;5078.568321692624;5081.618878584121;4992.375953005874;5038.269450929594;5041.143005689041;5042.823501177478;5061.2661164131;5324.281222035053;5564.415736347706;5570.220169176318;5575.916361254584;5579.9163012554845;4875.268709693539;6045.969770151121;6056.939430605682;6081.452669259788;6108.847278818021;5862.853428664275;5935.614185077956;5990.910136347915;6001.189839371673;6055.848603784896;4039.4142849287277;5497.5601951843755;5535.391106978229;5544.1960915667405;5553.444655534455;6164.044573091178;6221.3156552779155;6229.7508099676415;6243.469305109116;6249.375062493805;5941.524678025748;5960.970195148997;5978.342382337939;5984.209715645684;5998.70006499682;5899.7050147492455;5975.073863551156;6068.4841788448475;6097.4817140543555;6103.816885493442;5468.316460442445;5638.154276858422;5917.082852157922;5989.131575921554;6097.603655762361;6031.24609423822;6043.758249670052;6076.301225359052;6083.300420451616;6095.512359011268;4686.7656617169005;4817.373741413664;4824.589909857631;4841.419029716386;4843.104025755247;4193.517745459311;4202.348635961431;4217.261979153697;4231.936520952188;4282.63597594208;5392.703401312965;5419.864503387447;5422.566194704415;5429.104197807317;5459.317585301837;5881.2942446906645;5888.970555147197;5891.145783861316;5899.793507227227;5907.084401917709;5363.5440987516495;5395.541378982752;5403.459654034565;5413.10683737179;5511.807086752025;5262.2632831403635;5270.736463176826;5277.525022747971;5308.256844041837;5312.73436328182;6163.19878415803;6191.19514463117;6220.222472190976;6243.750249989949;6248.156498872685;5883.146943693226;5900.291964964232;6116.847078823065;6132.233470816148;6165.10605962124;6135.998322733915;6139.76813534272;6140.688304616386;6197.442230199304;6221.751129954751;5997.730102145327;6021.397860213943;6029.78895738647;6041.426064523863;6045.939540604713;6041.728122234422;6058.27300723916;6115.4190351916495;6119.418655227746;6124.785632502841;5099.158638824552;5648.774049037993;5711.600187986801;5767;5904.084866845646;5609.80365687199;5753.539716822728;5814.680192589448;5828.53371730269;5954.821355359346;5721.313442386941;5733.5126514245085;5734.713264336683;5737.168110623853;5739.139129130664;5817.156512305776;5887.205227294432;5895.94104058954;5897.085951677497;5905.43898329658;5497.697626630574;5504.80733174337;5511.173324001432;5567.66594004361;5586.692731899784 06:07:35 INFO - PROCESS | 2868 | |1;ext.html;469.8097270605404;483.6179418259573;485.53146213903585;493.2847371311599;493.8024790083966;22467.887660561693;38816.61183388165;40175.39736903945;40251.19497610046;41756.79121604395;41492;41626.58373416265;41829.79085104578;41878.790606046925;41923.742287731344;6457.062036773257;9321.067893210675;9490.478023708692;9510.429374237534;9514.048595140499;7449.590272535009;11418.371989540572;11520.827187592193;11624.82562761555;11646.126540509453;11352;11400.885991140107;11402.828957565644;11438.19932604718;11466.598669046585;7383.667734951886;10559.841602375971;11263.26788758728;11280;11358.375289359083;7459.104907411145;11071.72320691981;11337.94331028348;11343.489542970587;11429.942850285695;38941.80529097365;39374.20338390035;39586.0103497412;39773.80113099416;39789.20421591552;3751.3435148849117;3800.5629352624524;3803.3344164771056;3828.349180639298;3896.201278737852;29986.85006574953;30142.54786178209;30231.848840755654;30255.243618909484;30386.696133038608;2604.348912771807;3042.3915216956475;3081.168084617163;3143.0413723814227;3196.4725820239632;429691;431140;432420;432880;441790.79104604595;58830.11754823681;58955.914037622184;58999.41000589939;59107.70446147742;59199;59265;59542;59696.70151649214;59797;59801.70099149476;14616.926915365355;14804.62988425298;14822.777658335133;14831.70336593262;14832.629184270263;11317.49071291794;11351.943240283746;11376.374299413612;11392.145589080852;11397.772044559062;12860.356982150855;13055.804162937564;13975.440982360795;15959.521214363587;16135.707074241056;6647.235567909655;6776.610794787057;6806.596701649175;6812.625305608239;6822.215445223764;790.9723159689383;800.5916982339049;801.6833350826391;812.4353574265947;831.3432388413207;27848.303792405353;27900.02349917743;28264;28497.71502284992;28605.855765769134;987.1214618989105;990.8662330585423;1028.2545154762886;1042.338115296792;1177.682025853015;13006.349682515836;14089.718205636034;14278.571642850731;14387.208703521406;14730.779038314435;531521;536942;536975;537894;539836;55541.44458555443;55711.885762284524;55828.604284893205;56077.43922560804;56337.71831140818;1311.7245378470627;1363.277462944641;1365.0649305225952;1369.5548946592398;1373.7527245095978;27503;27698.86150569234;27711.44577108487;28634.42731145407;28641.28396790097;46572.53427465682;47060.29409558791;47108.52891471041;47136.29295560638;47179;425447;427371.3577185379;428007;428545;428746;35625.643743562236;36042;36349.636503634625;36444.45333320055;36690.63309366872;38629.806850965564;39940.201195975336;43903.12193756171;43948.12103757843;44055.89860253519;31978.52032219472;32342.83828580936;32419.837900810344;33399;33742.66257337395;32214.67785322117;32696.673033270315;33893;34175.316493670485;34279.31441371109;33513.832430838665;33827.98516044523;33891;33969.66030339665;33974.49038264379;27061.59407608927;29584.704152958195;29739;30175.698243018167;30774.197072860534;22514.98682559256;22609;22804.087836486353;23044.539109217385;23075 06:07:35 INFO - PROCESS | 2868 | |2;jquery.html;356.0724313164209;368.3682484539016;370.5275773388928;389.12641120684066;417.0595307581405;13587.592372228837;14016.789748153773;14515.85484145157;20359;20854.791452085476;20480.89759551204;20936.581268374623;21434.678479822815;21967;21981.450463738416;5621.887562248773;5762.250907382045;6009.549283803733;6022.789202377918;6028.788992385267;5918.408159184069;6041.124037014631;6066.848328791772;6068.241469816273;6083.057126145432;2955.2316397736636;3751.362268414376;5133.794648214067;5996.790112346069;6065.302490213616;5234.5027222414;6071.817845464599;6081.604695694788;6088.878222435571;6115.296740874812;5191.169412893956;5427.728613569345;5484.177373393983;5512.283403157604;5543.6396634218645;13310.800337994939;13423.463061477529;13455.259960702157;13503.392347344394;13657.590272291847;2449.669294645218;2475.517274131545;2484.503099380131;2532.8733563321944;2546.401595625027;9793.755156121082;14294.64263393413;14432.278386080654;14704.117752934751;15451.690966180613;1710.8802383833136;1773.5388798912247;1786.883852549593;1810.6921823290072;1834.4588346437833;106029;109684.9999999992;124600.37699811533;131740.99999999904;134360;10857.51141198648;10863;11395.943020284845;11613.535458581562;12013.176903427688;15372.077675339515;15372.385104595915;15397.846021539865;15416.768748468781;15427.291901996334;8042.959785201154;8242.917570824335;8247.670093196204;8423.452475589189;8454.746357609281;7585.355244804143;7644.617769111522;7873.881891771628;8027.357811375076;8213.917860821435;3774.7168962327937;4611.354410382549;4641.535846415399;4663.592904705021;4737.786799594027;1987.8012198780295;1999.850011249133;2002.2191345375315;2013.4865609269837;2021.6462119129094;812.6668066092874;951.5004622573205;978.8287049766262;991.7074463033423;1024.3802499487851;19897.403077907686;20440.933859920835;21099.578008439745;21187;21321.573568528544;947.5877993073035;988.584794386345;994.8906968729814;1047.5652604169336;1052.5789684126257;10285.948570257251;10840.837387439195;10939.617113400993;11102.056325212447;11143.33140011602;487282.5635871798;553062;565571;571159;574639;126258;127101;130538;130925;132401;898.8786513820681;935.9096652400013;1030.644427672452;1044.1072882685346;1047.3867700088176;18813.247470101043;19775.901120494305;19800.504987375432;19851.801481984996;19895.502612434804;50739.74630126826;50960.572294125705;56494;56908.86182276414;57725.422745772004;71308.45272134704;71982;73311;75352.81325768078;75369;7269.781906542812;8126.918730812617;8142.068855212;8437.578121094044;8547.487150770974;8906.643734250816;10838.945805271238;12981.740365192833;13336.599902002956;13454.798178027533;11241.213115081866;11346.773064538498;11451.656450306504;11580.363080030342;11642.068634509389;10848.240623156618;11094.833577496505;11180.273282236629;11205;11307;11391.601293954673;11429.828552571551;11621.302721836717;11649.1263155262;11773.234739741889;8015.599220038858;8056.879146812919;8536.658533658585;8549.786255343666;8620.03478399943;9244.907550924405;9806.264530160124;10399.84400233982;11520.308781473139;11551.942240289081 06:07:35 INFO - PROCESS | 2868 | |3;mootools.html;1445.2484707951864;1447.7176950494659;1459.890508211884;1471.5144002479183;1480.4078368652538;7270.96364518178;7276.272372762721;8155.959220203898;8575.356848236375;8589.35579831512;8194.426390152677;8459.830803383944;8463.492190468576;8599.699010534632;8615.43999640023;2239.8656080635174;2265.2184996176375;2277.555876604063;2277.7266727992665;2282.8085038363192;2253.3690566641367;2289.0386037864137;2290.2213247495847;2291.5073259249257;2292.5529521743265;2243.3157886844506;2244.898979545916;2271.5343354612264;2274.363178310076;2276.7381751098587;1881.811818818114;2184.650455927044;2192.199847055829;2226.309843948365;2234.6201145805253;2172.2180015194517;2234.6648002799548;2239.317008312464;2240.305505293364;2241.8991145398495;8471.534065626389;8544.914550854473;8547.230749232598;8550.87173692389;8564.61459234336;5031.924521132186;5181;5212.582993360522;5213.556847667953;5223.085959956992;2868.741813236819;3184.5541624172633;3251.463508521091;3471.826408679581;3475.1138459692615;1171.6953592066125;1178.3048001678965;1214.502054157791;1232.876712328769;1242.198781785752;9996.700098997042;10349.534270957825;10358.43028633425;10790.082842958358;10852.348859068481;3595.334863050344;4390.538993405647;4394.802233899482;4434.201843668106;4442.20040392726;8746;8751.256143227769;8752.69365572202;8762.167594078552;8784.385093043553;4413.227685155085;4553.977230113828;4559.156556037144;5093.159628661304;5143.17709166539;4612.538746125428;4774.331593576902;4817.735024573612;4838.250071238964;4853.053654537332;3377.560917080813;3551.804650744234;3561.7684850484634;3626.220362621996;3647.76289541179;1116.3636727065657;1118.2675347647305;1126.7829551721238;1134.5802053240354;1137.9829302560468;746.8692978728809;865.6450855149484;879.560219890055;886.5655828644047;899.6311512280065;5275.261463395128;5576.776928922797;5761.3991255465335;5783.450572195635;5953.880922381615;916.9908300917039;933.4725879877848;953.7663272498144;954.5656726189567;956.7368973532195;3512.1570823002808;3552.946705799415;3580.5166302548823;3615;3686.760360576554;8809.647614095493;9558.996305387835;9696.854547181798;10035.147012503872;10054.245931555162;9939.701808945743;9953.303268771117;9990.252680512916;9994.10053095225;10007.09936105754;7252.202257751643;7476.626168691544;7598.164201937782;7621.894825250308;7644.732434364882;5313.229581710708;5537.640053396516;5656.377798442086;5691.203231547669;5731.054376027909;8666.436681615674;8702.47785132894;8712.21590056898;9009.954950225207;9296.488693121943;8313.12712165214;8363.790905227417;8575.356848236283;8649.437786543855;9226.584803683716;6990.545614535039;7126.35862772353;7254.854902902018;7267.418606511572;7398.483310921356;7827.373810095292;8073.798155046171;8076;8080.83838323242;8094.959525202572;6964.930350696631;7073.646317684198;7073.82315442118;7089.858202836018;7179.676914538753;6657.40083392497;6692.866142677217;6837.726490940307;6912.135983002125;6953.721851125898;6099.512039036777;6233.688315584293;6349.333320001333;6357.618542887441;6378.585391949508;4863.586595139453;4890.975545122394;4943.233798761198;4944.8763780905765;5053.36832895888;4877.731724755031;4901.730404827768;4924.015196960694;5010.49895010496;5043.52086551777 06:07:35 INFO - PROCESS | 2868 | |4;prototype.html;295.8919994202116;342.9794212347258;361.28826212361656;361.6889475051456;363.2915814162384;5278.841634750959;5319.20211968205;5327.8033180091925;5344.465553444663;5350.732463376826;4344.7175933564295;4602.930956035662;4941.331680892323;5148.48515148485;5176.197689358146;3835.61643835617;3932.2725295820223;3948.7689455457717;3949.9605003950023;3952.3281042222893;3172.3662313908358;3335.5997280326396;3950.42718805773;3963.7225394222414;3974.225026119908;3259.3807176636483;3526.612072672004;3532.664396882305;3870.5355357357016;3914.178022615254;3230.56387387702;3544.680978711928;3861;3931.0761970936805;3944.132290896013;3353.2455197580593;3365.7980521168806;3366.646502117291;3368.696817286456;3370.3764803511185;4847.515248475124;5011.223260394609;5050.343455350818;5063.54428101469;5065.670731402447;3539.4513850353237;4116.732412393185;4397.768624785033;4431.734095954221;4487.506374298824;4902.921357301424;5015.699058056528;5057.595392368602;5511.255980442629;5531.9723401383135;3555.6799888010205;3709.7217708671956;3725.3853114236117;3734.5518537775642;3751;5546;5802.752408232208;5816.964062578106;5827.35899051104;5857.619254748428;3787.7348585599293;3792.544894612664;3796.962030379661;3801.790901500389;3839.0978120142304;3260.836958152083;3482.791032538056;3595.460680897886;3856.9421458678144;3862.787546684959;3753.0242137044565;3993.1813978134414;3995.4805875236034;4469.966165394738;4506.904289505395;4699.600533954652;4863.443698016601;5088.414832294259;5461.678786515715;5513.924784666951;1134.3098782813713;1143.3254379915722;1147.8106112491346;1234.4444999750149;1268.35313989864;743.271593838031;772.5094564951296;798.6406117247262;827.3174630929507;863.1756672377865;4384.802683879169;4385.846495372711;4450.552196292027;4653.6033942519625;4881.4630390657;4464.062546865194;5094.592432605383;5139.922901156486;5415.508865921642;5472.288602481732;4304.139172165516;4441.467023957146;4593.04997701976;4864.878378040577;4882.658213925062;2577.7497913511934;2606.5699159638825;2623.737626237361;2743.684476285213;2815.366542527915;4621.722696638212;5022.518357084668;5522.751476183581;5623.381428042912;5687.118496633028;4815.614750819926;4892.287699305215;5109.795608175706;5579.860503487364;5605.766731319103;4829.46453112119;4899.485554016848;5149.6910185389;5321.36143662763;5677.290338707661;4915.139850526072;5398.46015398457;5431.429699881455;5443.863903402288;5448.318960129984;4919.877003074952;5017.974910125426;5105.33630628016;5308.442613525524;5382.246485492113;5005.474425185449;5213;5373.9731301343245;5587.870792356293;5633.436656334334;2989.402119576137;3577.7495575309476;3622.2755448910852;3625.078708284613;3632.927341453103;4472.597466228055;4858.7570621469495;4888.535589119028;4964.528369804862;5158.337580317866;4425.623821975039;4834.341112388102;5225.8122545248125;5252;5254.395744489279;4731.645126615449;4736.537000759517;4933.076100320949;5240.737963101906;5271.4464981176425;4496.932546011747;4611.377464042445;4866.343043689057;4963.327137917842;5094.2867998479505;5233.685978841282;5242.370915490165;5261.447548007557;5265.893642543014;5274.208868669731;4808.807647694053;4842.927356089732;4976.552110310089;5129.230615407719;5159.690418574897 06:07:35 INFO - PROCESS | 2868 | |5;yui.html;677.7390704578736;710.9466789990748;718.7412531488663;754.5736658787785;807.132332742302;14049.578512644624;14070.718585628281;14385.136891786475;14622.049566778165;14631.122132672048;13295.667608309797;13485.865141348584;13563.321833908314;13724.176549407042;13769.65575860604;895.073598825216;897.0670502677208;897.4570384917129;898.9146031127033;904.9185573298402;878.2578720980761;906.4515967839461;910.3036177324352;910.5993362920327;913.4701872913728;974.4494360686225;974.6247694637544;975.4050029482011;976.2921881635792;977.5063592885583;971.3443425687633;972.023116767651;972.0328273368044;972.4408465132542;973.0609961387224;718.267367285366;719.144218380126;719.6186021408662;720.9170945341248;721.4841388407314;14728.116313021254;15159.393624255017;15207.847921520754;15245.237738113161;15262.236888155549;13632.93183534076;13684.178949263076;13817.170969741848;13824.930875345659;14011.64970875726;11055.834162487568;11084.556617735361;11209.215354925158;11401;11719;3617.5658920929395;3653.2510835278704;3743.794091324976;3763.0216143802536;3767.4348847672795;88095.55952220262;88321;91022.1795564085;92626;93620;10359.533820977924;10371.222158338154;10410.68767936963;10463.319884207502;10501.422421766723;20194.798052019585;21625.026873790717;21801;21899.67150492744;21959;7089.8884191558745;7560.256632564657;7598.506097103671;7604.961975190088;7680.769576912701;4001.079751657135;4107.979460102681;4148.357004664282;4159.251334759772;4169.520505141887;3421.349943510725;3504.3867323218847;3518.82405879705;3521.031716278044;3525.5945566259697;643.7939859244997;646.4505170604948;649.9285078641345;669.6819010969848;669.8024082895557;599.484443378694;599.712138173679;659.2747977225014;664.4850241063118;693.9236683964759;9213.63145474187;9306.348555601178;9666.806663866684;9680.370775899544;9812.96963818803;617.3795335687605;625.7903602293283;670.4368330602317;679.2785388580071;725.2167658928345;4245.957540424618;4688.437387513521;4689.1559519286175;4700.130475861976;4774.2599897015325;76730.6163469179;90758.63862042075;95870;96172.14835549307;98034.50982745041;80842.59578702069;82155.5892220535;83149;83181.16818831855;86750.56624716836;63952;72233;74253;74428.25571744321;76307.61846190733;9088.863667045132;9135.543222838964;9137.862932056158;9240.306976976619;9246.583903724482;41852.790736046125;43266;43657.69026929197;47156.76421618007;47356;60223.69888150531;62389;62441.687791560755;62858;64552.67723661352;12321.753564928831;12568.74862502763;12585.181963172365;13011.934940325238;13112.803307950198;11903.702407439883;13833.654158646114;13872.306384680523;13939.581812545639;14027.649308767363;12884;12999.805002924775;13032.934835325763;13051.28217948022;13083.280419577015;12613.936930315289;12772.361381930681;12981.228125994152;13100.934495327463;13176.341182940623;12542.623721288375;12560.74878502443;12825.294608796607;12866.485340586272;13569;9479.176492198332;9905.306628535933;10042.246831487813;10224.488775561342;10382.636607718694;10019.499025048864;10230;10246.322017352912;10342.32774869631;10412.114970227616 06:07:35 INFO - PROCESS | 2868 | __end_tp_report 06:07:35 INFO - PROCESS | 2868 | __start_cc_report 06:07:35 INFO - PROCESS | 2868 | _x_x_mozilla_cycle_collect,1791 06:07:35 INFO - PROCESS | 2868 | __end_cc_report 06:07:35 INFO - PROCESS | 2868 | __startTimestamp1489410455201__endTimestamp 06:07:35 INFO - PROCESS | 2868 | 06:07:35 INFO - PROCESS | 2868 | ------- Summary: start ------- 06:07:35 INFO - PROCESS | 2868 | Number of tests: 6 06:07:35 INFO - PROCESS | 2868 | 06:07:35 INFO - PROCESS | 2868 | [#0] dojo.html Cycles:165 Average:5517.10 Median:5586.69 stddev:649.71 (11.6%) stddev-sans-first:612.22 06:07:35 INFO - PROCESS | 2868 | Values: 2674.0 3212.8 3240.5 3241.3 3257.1 5280.1 5406.4 5454.4 5502.3 5511.0 5416.5 5424.0 5425.4 5429.6 5430.0 4950.8 4965.5 4995.5 5046.8 5077.0 4972.7 5080.8 5083.8 5086.2 5095.5 5068.4 5073.0 5077.0 5078.9 5080.7 5061.5 5075.5 5077.1 5078.6 5081.6 4992.4 5038.3 5041.1 5042.8 5061.3 5324.3 5564.4 5570.2 5575.9 5579.9 4875.3 6046.0 6056.9 6081.5 6108.8 5862.9 5935.6 5990.9 6001.2 6055.8 4039.4 5497.6 5535.4 5544.2 5553.4 6164.0 6221.3 6229.8 6243.5 6249.4 5941.5 5961.0 5978.3 5984.2 5998.7 5899.7 5975.1 6068.5 6097.5 6103.8 5468.3 5638.2 5917.1 5989.1 6097.6 6031.2 6043.8 6076.3 6083.3 6095.5 4686.8 4817.4 4824.6 4841.4 4843.1 4193.5 4202.3 4217.3 4231.9 4282.6 5392.7 5419.9 5422.6 5429.1 5459.3 5881.3 5889.0 5891.1 5899.8 5907.1 5363.5 5395.5 5403.5 5413.1 5511.8 5262.3 5270.7 5277.5 5308.3 5312.7 6163.2 6191.2 6220.2 6243.8 6248.2 5883.1 5900.3 6116.8 6132.2 6165.1 6136.0 6139.8 6140.7 6197.4 6221.8 5997.7 6021.4 6029.8 6041.4 6045.9 6041.7 6058.3 6115.4 6119.4 6124.8 5099.2 5648.8 5711.6 5767.0 5904.1 5609.8 5753.5 5814.7 5828.5 5954.8 5721.3 5733.5 5734.7 5737.2 5739.1 5817.2 5887.2 5895.9 5897.1 5905.4 5497.7 5504.8 5511.2 5567.7 5586.7 06:07:35 INFO - PROCESS | 2868 | 06:07:35 INFO - PROCESS | 2868 | [#1] ext.html Cycles:180 Average:60508.26 Median:34952.48 stddev:124602.59 (356.5%) stddev-sans-first:124870.59 06:07:35 INFO - PROCESS | 2868 | Values: 469.8 483.6 485.5 493.3 493.8 22467.9 38816.6 40175.4 40251.2 41756.8 41492.0 41626.6 41829.8 41878.8 41923.7 6457.1 9321.1 9490.5 9510.4 9514.0 7449.6 11418.4 11520.8 11624.8 11646.1 11352.0 11400.9 11402.8 11438.2 11466.6 7383.7 10559.8 11263.3 11280.0 11358.4 7459.1 11071.7 11337.9 11343.5 11429.9 38941.8 39374.2 39586.0 39773.8 39789.2 3751.3 3800.6 3803.3 3828.3 3896.2 29986.9 30142.5 30231.8 30255.2 30386.7 2604.3 3042.4 3081.2 3143.0 3196.5 429691.0 431140.0 432420.0 432880.0 441790.8 58830.1 58955.9 58999.4 59107.7 59199.0 59265.0 59542.0 59696.7 59797.0 59801.7 14616.9 14804.6 14822.8 14831.7 14832.6 11317.5 11351.9 11376.4 11392.1 11397.8 12860.4 13055.8 13975.4 15959.5 16135.7 6647.2 6776.6 6806.6 6812.6 6822.2 791.0 800.6 801.7 812.4 831.3 27848.3 27900.0 28264.0 28497.7 28605.9 987.1 990.9 1028.3 1042.3 1177.7 13006.3 14089.7 14278.6 14387.2 14730.8 531521.0 536942.0 536975.0 537894.0 539836.0 55541.4 55711.9 55828.6 56077.4 56337.7 1311.7 1363.3 1365.1 1369.6 1373.8 27503.0 27698.9 27711.4 28634.4 28641.3 46572.5 47060.3 47108.5 47136.3 47179.0 425447.0 427371.4 428007.0 428545.0 428746.0 35625.6 36042.0 36349.6 36444.5 36690.6 38629.8 39940.2 43903.1 43948.1 44055.9 31978.5 32342.8 32419.8 33399.0 33742.7 32214.7 32696.7 33893.0 34175.3 34279.3 33513.8 33828.0 33891.0 33969.7 33974.5 27061.6 29584.7 29739.0 30175.7 30774.2 22515.0 22609.0 22804.1 23044.5 23075.0 06:07:35 INFO - PROCESS | 2868 | 06:07:35 INFO - PROCESS | 2868 | [#2] jquery.html Cycles:180 Average:33435.77 Median:21974.23 stddev:92633.35 (421.6%) stddev-sans-first:92859.91 06:07:35 INFO - PROCESS | 2868 | Values: 356.1 368.4 370.5 389.1 417.1 13587.6 14016.8 14515.9 20359.0 20854.8 20480.9 20936.6 21434.7 21967.0 21981.5 5621.9 5762.3 6009.5 6022.8 6028.8 5918.4 6041.1 6066.8 6068.2 6083.1 2955.2 3751.4 5133.8 5996.8 6065.3 5234.5 6071.8 6081.6 6088.9 6115.3 5191.2 5427.7 5484.2 5512.3 5543.6 13310.8 13423.5 13455.3 13503.4 13657.6 2449.7 2475.5 2484.5 2532.9 2546.4 9793.8 14294.6 14432.3 14704.1 15451.7 1710.9 1773.5 1786.9 1810.7 1834.5 106029.0 109685.0 124600.4 131741.0 134360.0 10857.5 10863.0 11395.9 11613.5 12013.2 15372.1 15372.4 15397.8 15416.8 15427.3 8043.0 8242.9 8247.7 8423.5 8454.7 7585.4 7644.6 7873.9 8027.4 8213.9 3774.7 4611.4 4641.5 4663.6 4737.8 1987.8 1999.9 2002.2 2013.5 2021.6 812.7 951.5 978.8 991.7 1024.4 19897.4 20440.9 21099.6 21187.0 21321.6 947.6 988.6 994.9 1047.6 1052.6 10285.9 10840.8 10939.6 11102.1 11143.3 487282.6 553062.0 565571.0 571159.0 574639.0 126258.0 127101.0 130538.0 130925.0 132401.0 898.9 935.9 1030.6 1044.1 1047.4 18813.2 19775.9 19800.5 19851.8 19895.5 50739.7 50960.6 56494.0 56908.9 57725.4 71308.5 71982.0 73311.0 75352.8 75369.0 7269.8 8126.9 8142.1 8437.6 8547.5 8906.6 10838.9 12981.7 13336.6 13454.8 11241.2 11346.8 11451.7 11580.4 11642.1 10848.2 11094.8 11180.3 11205.0 11307.0 11391.6 11429.8 11621.3 11649.1 11773.2 8015.6 8056.9 8536.7 8549.8 8620.0 9244.9 9806.3 10399.8 11520.3 11551.9 06:07:35 INFO - PROCESS | 2868 | 06:07:35 INFO - PROCESS | 2868 | [#3] mootools.html Cycles:180 Average:5319.91 Median:5218.32 stddev:2901.76 (55.6%) stddev-sans-first:2895.29 06:07:35 INFO - PROCESS | 2868 | Values: 1445.2 1447.7 1459.9 1471.5 1480.4 7271.0 7276.3 8156.0 8575.4 8589.4 8194.4 8459.8 8463.5 8599.7 8615.4 2239.9 2265.2 2277.6 2277.7 2282.8 2253.4 2289.0 2290.2 2291.5 2292.6 2243.3 2244.9 2271.5 2274.4 2276.7 1881.8 2184.7 2192.2 2226.3 2234.6 2172.2 2234.7 2239.3 2240.3 2241.9 8471.5 8544.9 8547.2 8550.9 8564.6 5031.9 5181.0 5212.6 5213.6 5223.1 2868.7 3184.6 3251.5 3471.8 3475.1 1171.7 1178.3 1214.5 1232.9 1242.2 9996.7 10349.5 10358.4 10790.1 10852.3 3595.3 4390.5 4394.8 4434.2 4442.2 8746.0 8751.3 8752.7 8762.2 8784.4 4413.2 4554.0 4559.2 5093.2 5143.2 4612.5 4774.3 4817.7 4838.3 4853.1 3377.6 3551.8 3561.8 3626.2 3647.8 1116.4 1118.3 1126.8 1134.6 1138.0 746.9 865.6 879.6 886.6 899.6 5275.3 5576.8 5761.4 5783.5 5953.9 917.0 933.5 953.8 954.6 956.7 3512.2 3552.9 3580.5 3615.0 3686.8 8809.6 9559.0 9696.9 10035.1 10054.2 9939.7 9953.3 9990.3 9994.1 10007.1 7252.2 7476.6 7598.2 7621.9 7644.7 5313.2 5537.6 5656.4 5691.2 5731.1 8666.4 8702.5 8712.2 9010.0 9296.5 8313.1 8363.8 8575.4 8649.4 9226.6 6990.5 7126.4 7254.9 7267.4 7398.5 7827.4 8073.8 8076.0 8080.8 8095.0 6964.9 7073.6 7073.8 7089.9 7179.7 6657.4 6692.9 6837.7 6912.1 6953.7 6099.5 6233.7 6349.3 6357.6 6378.6 4863.6 4891.0 4943.2 4944.9 5053.4 4877.7 4901.7 4924.0 5010.5 5043.5 06:07:35 INFO - PROCESS | 2868 | 06:07:35 INFO - PROCESS | 2868 | [#4] prototype.html Cycles:180 Average:4255.50 Median:4831.90 stddev:1303.01 (27.0%) stddev-sans-first:1272.32 06:07:35 INFO - PROCESS | 2868 | Values: 295.9 343.0 361.3 361.7 363.3 5278.8 5319.2 5327.8 5344.5 5350.7 4344.7 4602.9 4941.3 5148.5 5176.2 3835.6 3932.3 3948.8 3950.0 3952.3 3172.4 3335.6 3950.4 3963.7 3974.2 3259.4 3526.6 3532.7 3870.5 3914.2 3230.6 3544.7 3861.0 3931.1 3944.1 3353.2 3365.8 3366.6 3368.7 3370.4 4847.5 5011.2 5050.3 5063.5 5065.7 3539.5 4116.7 4397.8 4431.7 4487.5 4902.9 5015.7 5057.6 5511.3 5532.0 3555.7 3709.7 3725.4 3734.6 3751.0 5546.0 5802.8 5817.0 5827.4 5857.6 3787.7 3792.5 3797.0 3801.8 3839.1 3260.8 3482.8 3595.5 3856.9 3862.8 3753.0 3993.2 3995.5 4470.0 4506.9 4699.6 4863.4 5088.4 5461.7 5513.9 1134.3 1143.3 1147.8 1234.4 1268.4 743.3 772.5 798.6 827.3 863.2 4384.8 4385.8 4450.6 4653.6 4881.5 4464.1 5094.6 5139.9 5415.5 5472.3 4304.1 4441.5 4593.0 4864.9 4882.7 2577.7 2606.6 2623.7 2743.7 2815.4 4621.7 5022.5 5522.8 5623.4 5687.1 4815.6 4892.3 5109.8 5579.9 5605.8 4829.5 4899.5 5149.7 5321.4 5677.3 4915.1 5398.5 5431.4 5443.9 5448.3 4919.9 5018.0 5105.3 5308.4 5382.2 5005.5 5213.0 5374.0 5587.9 5633.4 2989.4 3577.7 3622.3 3625.1 3632.9 4472.6 4858.8 4888.5 4964.5 5158.3 4425.6 4834.3 5225.8 5252.0 5254.4 4731.6 4736.5 4933.1 5240.7 5271.4 4496.9 4611.4 4866.3 4963.3 5094.3 5233.7 5242.4 5261.4 5265.9 5274.2 4808.8 4842.9 4976.6 5129.2 5159.7 06:07:35 INFO - PROCESS | 2868 | 06:07:35 INFO - PROCESS | 2868 | [#5] yui.html Cycles:180 Average:18875.69 Median:47256.38 stddev:26309.82 (55.7%) stddev-sans-first:26348.14 06:07:35 INFO - PROCESS | 2868 | Values: 677.7 710.9 718.7 754.6 807.1 14049.6 14070.7 14385.1 14622.0 14631.1 13295.7 13485.9 13563.3 13724.2 13769.7 895.1 897.1 897.5 898.9 904.9 878.3 906.5 910.3 910.6 913.5 974.4 974.6 975.4 976.3 977.5 971.3 972.0 972.0 972.4 973.1 718.3 719.1 719.6 720.9 721.5 14728.1 15159.4 15207.8 15245.2 15262.2 13632.9 13684.2 13817.2 13824.9 14011.6 11055.8 11084.6 11209.2 11401.0 11719.0 3617.6 3653.3 3743.8 3763.0 3767.4 88095.6 88321.0 91022.2 92626.0 93620.0 10359.5 10371.2 10410.7 10463.3 10501.4 20194.8 21625.0 21801.0 21899.7 21959.0 7089.9 7560.3 7598.5 7605.0 7680.8 4001.1 4108.0 4148.4 4159.3 4169.5 3421.3 3504.4 3518.8 3521.0 3525.6 643.8 646.5 649.9 669.7 669.8 599.5 599.7 659.3 664.5 693.9 9213.6 9306.3 9666.8 9680.4 9813.0 617.4 625.8 670.4 679.3 725.2 4246.0 4688.4 4689.2 4700.1 4774.3 76730.6 90758.6 95870.0 96172.1 98034.5 80842.6 82155.6 83149.0 83181.2 86750.6 63952.0 72233.0 74253.0 74428.3 76307.6 9088.9 9135.5 9137.9 9240.3 9246.6 41852.8 43266.0 43657.7 47156.8 47356.0 60223.7 62389.0 62441.7 62858.0 64552.7 12321.8 12568.7 12585.2 13011.9 13112.8 11903.7 13833.7 13872.3 13939.6 14027.6 12884.0 12999.8 13032.9 13051.3 13083.3 12613.9 12772.4 12981.2 13100.9 13176.3 12542.6 12560.7 12825.3 12866.5 13569.0 9479.2 9905.3 10042.2 10224.5 10382.6 10019.5 10230.0 10246.3 10342.3 10412.1 06:07:35 INFO - PROCESS | 2868 | -------- Summary: end -------- 06:07:35 INFO - PROCESS | 2868 | 06:07:35 INFO - TEST-INFO | 2868: exit 0 06:07:35 INFO - TEST-OK | dromaeo_css | took 1119208ms 06:07:35 INFO - TEST-START | kraken 06:07:35 INFO - operating with platform_type : mac_ 06:07:35 INFO - Initialising browser for kraken test... 06:07:35 INFO - TEST-INFO | started process 2982 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpm1nSmD/profile http://localhost:62751/getInfo.html) 06:07:38 INFO - PROCESS | 2982 | __metrics Screen width/height:1600/1200 06:07:38 INFO - PROCESS | 2982 | colorDepth:24 06:07:38 INFO - PROCESS | 2982 | Browser inner width/height: 1024/689 06:07:38 INFO - PROCESS | 2982 | __metrics 06:07:38 INFO - PROCESS | 2982 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:07:38 INFO - PROCESS | 2982 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:07:39 INFO - TEST-INFO | 2982: exit 0 06:07:39 INFO - Browser initialized. 06:07:39 INFO - Running cycle 1/1 for kraken test... 06:07:39 INFO - TEST-INFO | started process 2983 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpm1nSmD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:07:51 INFO - PROCESS | 2983 | RSS: Main: 236306432 06:07:51 INFO - PROCESS | 2983 | 06:07:54 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:62751/tests/kraken/driver.html?testName=audio-beat-detection) 06:07:55 INFO - PROCESS | 2983 | RSS: Main: 289079296 06:07:55 INFO - PROCESS | 2983 | 06:07:57 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:62751/tests/kraken/driver.html?testName=audio-dft) 06:07:58 INFO - PROCESS | 2983 | RSS: Main: 290779136 06:07:58 INFO - PROCESS | 2983 | 06:08:01 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:62751/tests/kraken/driver.html?testName=audio-fft) 06:08:02 INFO - PROCESS | 2983 | RSS: Main: 382205952 06:08:02 INFO - PROCESS | 2983 | 06:08:04 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:62751/tests/kraken/driver.html?testName=audio-oscillator) 06:08:04 INFO - PROCESS | 2983 | RSS: Main: 284852224 06:08:04 INFO - PROCESS | 2983 | 06:08:07 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:62751/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:08:07 INFO - PROCESS | 2983 | RSS: Main: 287854592 06:08:07 INFO - PROCESS | 2983 | 06:08:10 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:62751/tests/kraken/driver.html?testName=imaging-darkroom) 06:08:11 INFO - PROCESS | 2983 | RSS: Main: 330297344 06:08:11 INFO - PROCESS | 2983 | 06:08:14 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:62751/tests/kraken/driver.html?testName=imaging-desaturate) 06:08:14 INFO - PROCESS | 2983 | RSS: Main: 333111296 06:08:14 INFO - PROCESS | 2983 | 06:08:17 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:62751/tests/kraken/driver.html?testName=json-parse-financial) 06:08:18 INFO - PROCESS | 2983 | RSS: Main: 327962624 06:08:18 INFO - PROCESS | 2983 | 06:08:20 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:62751/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:08:20 INFO - PROCESS | 2983 | RSS: Main: 305745920 06:08:20 INFO - PROCESS | 2983 | 06:08:22 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:62751/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:08:23 INFO - PROCESS | 2983 | RSS: Main: 310378496 06:08:23 INFO - PROCESS | 2983 | 06:08:25 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:62751/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:08:26 INFO - PROCESS | 2983 | RSS: Main: 310943744 06:08:26 INFO - PROCESS | 2983 | 06:08:29 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:62751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:08:30 INFO - PROCESS | 2983 | RSS: Main: 330645504 06:08:30 INFO - PROCESS | 2983 | 06:08:33 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:62751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:08:33 INFO - PROCESS | 2983 | RSS: Main: 324993024 06:08:33 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | Cycle 1(1): loaded http://localhost:62751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:62751/tests/kraken/driver.html?testName=ai-astar) 06:08:35 INFO - PROCESS | 2983 | RSS: Main: 370753536 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | __start_tp_report 06:08:35 INFO - PROCESS | 2983 | _x_x_mozilla_page_load 06:08:35 INFO - PROCESS | 2983 | _x_x_mozilla_page_load_details 06:08:35 INFO - PROCESS | 2983 | |i|pagename|runs| 06:08:35 INFO - PROCESS | 2983 | |0;ai-astar;113;115;115;115;114;115;115;115;113;115 06:08:35 INFO - PROCESS | 2983 | |1;audio-beat-detection;154;112;110;154;111;122;112;112;134;112 06:08:35 INFO - PROCESS | 2983 | |2;audio-dft;186;185;186;189;185;183;181;186;184;185 06:08:35 INFO - PROCESS | 2983 | |3;audio-fft;81;61;61;92;64;59;61;62;77;62 06:08:35 INFO - PROCESS | 2983 | |4;audio-oscillator;89;70;86;69;72;71;87;69;81;116 06:08:35 INFO - PROCESS | 2983 | |5;imaging-gaussian-blur;92;91;92;90;90;91;91;90;91;91 06:08:35 INFO - PROCESS | 2983 | |6;imaging-darkroom;96;97;110;151;149;97;99;98;97;102 06:08:35 INFO - PROCESS | 2983 | |7;imaging-desaturate;88;87;84;88;86;88;87;86;85;86 06:08:35 INFO - PROCESS | 2983 | |8;json-parse-financial;62;60;61;60;61;60;60;62;59;60 06:08:35 INFO - PROCESS | 2983 | |9;json-stringify-tinderbox;65;72;73;83;77;72;72;70;70;70 06:08:35 INFO - PROCESS | 2983 | |10;stanford-crypto-aes;95;94;93;93;94;94;98;97;115;114 06:08:35 INFO - PROCESS | 2983 | |11;stanford-crypto-ccm;149;168;156;156;132;146;148;146;191;164 06:08:35 INFO - PROCESS | 2983 | |12;stanford-crypto-pbkdf2;185;185;183;185;184;188;213;182;186;184 06:08:35 INFO - PROCESS | 2983 | |13;stanford-crypto-sha256-iterative;63;86;86;68;68;69;68;69;68;68 06:08:35 INFO - PROCESS | 2983 | __end_tp_report 06:08:35 INFO - PROCESS | 2983 | __start_cc_report 06:08:35 INFO - PROCESS | 2983 | _x_x_mozilla_cycle_collect,2129 06:08:35 INFO - PROCESS | 2983 | __end_cc_report 06:08:35 INFO - PROCESS | 2983 | __startTimestamp1489410515865__endTimestamp 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | ------- Summary: start ------- 06:08:35 INFO - PROCESS | 2983 | Number of tests: 14 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:0.85 (0.7%) stddev-sans-first:0.71 06:08:35 INFO - PROCESS | 2983 | Values: 113.0 115.0 115.0 115.0 114.0 115.0 115.0 115.0 113.0 115.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:117.00 stddev:17.76 (15.2%) stddev-sans-first:14.97 06:08:35 INFO - PROCESS | 2983 | Values: 154.0 112.0 110.0 154.0 111.0 122.0 112.0 112.0 134.0 112.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.50 stddev:2.11 (1.1%) stddev-sans-first:2.20 06:08:35 INFO - PROCESS | 2983 | Values: 186.0 185.0 186.0 189.0 185.0 183.0 181.0 186.0 184.0 185.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#3] audio-fft Cycles:10 Average:68.00 Median:63.00 stddev:11.26 (17.9%) stddev-sans-first:10.92 06:08:35 INFO - PROCESS | 2983 | Values: 81.0 61.0 61.0 92.0 64.0 59.0 61.0 62.0 77.0 62.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#4] audio-oscillator Cycles:10 Average:81.00 Median:76.50 stddev:14.68 (19.2%) stddev-sans-first:15.28 06:08:35 INFO - PROCESS | 2983 | Values: 89.0 70.0 86.0 69.0 72.0 71.0 87.0 69.0 81.0 116.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#5] imaging-gaussian-blur Cycles:10 Average:90.90 Median:91.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 06:08:35 INFO - PROCESS | 2983 | Values: 92.0 91.0 92.0 90.0 90.0 91.0 91.0 90.0 91.0 91.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#6] imaging-darkroom Cycles:10 Average:109.60 Median:97.00 stddev:21.69 (22.4%) stddev-sans-first:22.44 06:08:35 INFO - PROCESS | 2983 | Values: 96.0 97.0 110.0 151.0 149.0 97.0 99.0 98.0 97.0 102.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.00 stddev:1.35 (1.6%) stddev-sans-first:1.32 06:08:35 INFO - PROCESS | 2983 | Values: 88.0 87.0 84.0 88.0 86.0 88.0 87.0 86.0 85.0 86.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:60.50 stddev:0.97 (1.6%) stddev-sans-first:0.87 06:08:35 INFO - PROCESS | 2983 | Values: 62.0 60.0 61.0 60.0 61.0 60.0 60.0 62.0 59.0 60.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:72.00 stddev:4.79 (6.7%) stddev-sans-first:4.27 06:08:35 INFO - PROCESS | 2983 | Values: 65.0 72.0 73.0 83.0 77.0 72.0 72.0 70.0 70.0 70.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#10] stanford-crypto-aes Cycles:10 Average:98.70 Median:94.00 stddev:8.49 (9.0%) stddev-sans-first:8.89 06:08:35 INFO - PROCESS | 2983 | Values: 95.0 94.0 93.0 93.0 94.0 94.0 98.0 97.0 115.0 114.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#11] stanford-crypto-ccm Cycles:10 Average:155.60 Median:156.00 stddev:16.06 (10.3%) stddev-sans-first:16.85 06:08:35 INFO - PROCESS | 2983 | Values: 149.0 168.0 156.0 156.0 132.0 146.0 148.0 146.0 191.0 164.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.50 Median:185.00 stddev:9.11 (4.9%) stddev-sans-first:9.61 06:08:35 INFO - PROCESS | 2983 | Values: 185.0 185.0 183.0 185.0 184.0 188.0 213.0 182.0 186.0 184.0 06:08:35 INFO - PROCESS | 2983 | 06:08:35 INFO - PROCESS | 2983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:68.50 stddev:7.93 (11.6%) stddev-sans-first:7.82 06:08:35 INFO - PROCESS | 2983 | Values: 63.0 86.0 86.0 68.0 68.0 69.0 68.0 69.0 68.0 68.0 06:08:35 INFO - PROCESS | 2983 | -------- Summary: end -------- 06:08:35 INFO - PROCESS | 2983 | 06:08:36 INFO - TEST-INFO | 2983: exit 0 06:08:36 INFO - TEST-OK | kraken | took 60895ms 06:08:36 INFO - SUITE-END | took 1180s 06:08:37 INFO - Completed test suite (00:19:40) 06:08:37 INFO - javascript benchmark 06:08:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7000.344656858178, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2673.9866300668496, 3212.807231566106, 3240.5463235147067, 3241.319322942182, 3257.0554539183636, 5280.128778751511, 5406.405295417501, 5454.427285135063, 5502.339719233692, 5511.035568775464, 5416.539594134503, 5423.996560636285, 5425.430329815362, 5429.56563474922, 5429.972850135754, 4950.752462376885, 4965.528274813887, 4995.525425084629, 5046.798128074873, 5076.974615126937, 4972.651914365996, 5080.822171224008, 5083.822066227683, 5086.237064440326, 5095.541401273885, 5068.366454193226, 5073.0361231366105, 5076.984603079399, 5078.949210507884, 5080.720560369178, 5061.519155680223, 5075.543201111917, 5077.136886729247, 5078.568321692624, 5081.618878584121, 4992.375953005874, 5038.269450929594, 5041.143005689041, 5042.823501177478, 5061.2661164131, 5324.281222035053, 5564.415736347706, 5570.220169176318, 5575.916361254584, 5579.9163012554845, 4875.268709693539, 6045.969770151121, 6056.939430605682, 6081.452669259788, 6108.847278818021, 5862.853428664275, 5935.614185077956, 5990.910136347915, 6001.189839371673, 6055.848603784896, 4039.4142849287277, 5497.5601951843755, 5535.391106978229, 5544.1960915667405, 5553.444655534455, 6164.044573091178, 6221.3156552779155, 6229.7508099676415, 6243.469305109116, 6249.375062493805, 5941.524678025748, 5960.970195148997, 5978.342382337939, 5984.209715645684, 5998.70006499682, 5899.7050147492455, 5975.073863551156, 6068.4841788448475, 6097.4817140543555, 6103.816885493442, 5468.316460442445, 5638.154276858422, 5917.082852157922, 5989.131575921554, 6097.603655762361, 6031.24609423822, 6043.758249670052, 6076.301225359052, 6083.300420451616, 6095.512359011268, 4686.7656617169005, 4817.373741413664, 4824.589909857631, 4841.419029716386, 4843.104025755247, 4193.517745459311, 4202.348635961431, 4217.261979153697, 4231.936520952188, 4282.63597594208, 5392.703401312965, 5419.864503387447, 5422.566194704415, 5429.104197807317, 5459.317585301837, 5881.2942446906645, 5888.970555147197, 5891.145783861316, 5899.793507227227, 5907.084401917709, 5363.5440987516495, 5395.541378982752, 5403.459654034565, 5413.10683737179, 5511.807086752025, 5262.2632831403635, 5270.736463176826, 5277.525022747971, 5308.256844041837, 5312.73436328182, 6163.19878415803, 6191.19514463117, 6220.222472190976, 6243.750249989949, 6248.156498872685, 5883.146943693226, 5900.291964964232, 6116.847078823065, 6132.233470816148, 6165.10605962124, 6135.998322733915, 6139.76813534272, 6140.688304616386, 6197.442230199304, 6221.751129954751, 5997.730102145327, 6021.397860213943, 6029.78895738647, 6041.426064523863, 6045.939540604713, 6041.728122234422, 6058.27300723916, 6115.4190351916495, 6119.418655227746, 6124.785632502841, 5099.158638824552, 5648.774049037993, 5711.600187986801, 5767.0, 5904.084866845646, 5609.80365687199, 5753.539716822728, 5814.680192589448, 5828.53371730269, 5954.821355359346, 5721.313442386941, 5733.5126514245085, 5734.713264336683, 5737.168110623853, 5739.139129130664, 5817.156512305776, 5887.205227294432, 5895.94104058954, 5897.085951677497, 5905.43898329658, 5497.697626630574, 5504.80733174337, 5511.173324001432, 5567.66594004361, 5586.692731899784], "value": 5474.195916821271, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.8097270605404, 483.6179418259573, 485.53146213903585, 493.2847371311599, 493.8024790083966, 22467.887660561693, 38816.61183388165, 40175.39736903945, 40251.19497610046, 41756.79121604395, 41492.0, 41626.58373416265, 41829.79085104578, 41878.790606046925, 41923.742287731344, 6457.062036773257, 9321.067893210675, 9490.478023708692, 9510.429374237534, 9514.048595140499, 7449.590272535009, 11418.371989540572, 11520.827187592193, 11624.82562761555, 11646.126540509453, 11352.0, 11400.885991140107, 11402.828957565644, 11438.19932604718, 11466.598669046585, 7383.667734951886, 10559.841602375971, 11263.26788758728, 11280.0, 11358.375289359083, 7459.104907411145, 11071.72320691981, 11337.94331028348, 11343.489542970587, 11429.942850285695, 38941.80529097365, 39374.20338390035, 39586.0103497412, 39773.80113099416, 39789.20421591552, 3751.3435148849117, 3800.5629352624524, 3803.3344164771056, 3828.349180639298, 3896.201278737852, 29986.85006574953, 30142.54786178209, 30231.848840755654, 30255.243618909484, 30386.696133038608, 2604.348912771807, 3042.3915216956475, 3081.168084617163, 3143.0413723814227, 3196.4725820239632, 429691.0, 431140.0, 432420.0, 432880.0, 441790.79104604595, 58830.11754823681, 58955.914037622184, 58999.41000589939, 59107.70446147742, 59199.0, 59265.0, 59542.0, 59696.70151649214, 59797.0, 59801.70099149476, 14616.926915365355, 14804.62988425298, 14822.777658335133, 14831.70336593262, 14832.629184270263, 11317.49071291794, 11351.943240283746, 11376.374299413612, 11392.145589080852, 11397.772044559062, 12860.356982150855, 13055.804162937564, 13975.440982360795, 15959.521214363587, 16135.707074241056, 6647.235567909655, 6776.610794787057, 6806.596701649175, 6812.625305608239, 6822.215445223764, 790.9723159689383, 800.5916982339049, 801.6833350826391, 812.4353574265947, 831.3432388413207, 27848.303792405353, 27900.02349917743, 28264.0, 28497.71502284992, 28605.855765769134, 987.1214618989105, 990.8662330585423, 1028.2545154762886, 1042.338115296792, 1177.682025853015, 13006.349682515836, 14089.718205636034, 14278.571642850731, 14387.208703521406, 14730.779038314435, 531521.0, 536942.0, 536975.0, 537894.0, 539836.0, 55541.44458555443, 55711.885762284524, 55828.604284893205, 56077.43922560804, 56337.71831140818, 1311.7245378470627, 1363.277462944641, 1365.0649305225952, 1369.5548946592398, 1373.7527245095978, 27503.0, 27698.86150569234, 27711.44577108487, 28634.42731145407, 28641.28396790097, 46572.53427465682, 47060.29409558791, 47108.52891471041, 47136.29295560638, 47179.0, 425447.0, 427371.3577185379, 428007.0, 428545.0, 428746.0, 35625.643743562236, 36042.0, 36349.636503634625, 36444.45333320055, 36690.63309366872, 38629.806850965564, 39940.201195975336, 43903.12193756171, 43948.12103757843, 44055.89860253519, 31978.52032219472, 32342.83828580936, 32419.837900810344, 33399.0, 33742.66257337395, 32214.67785322117, 32696.673033270315, 33893.0, 34175.316493670485, 34279.31441371109, 33513.832430838665, 33827.98516044523, 33891.0, 33969.66030339665, 33974.49038264379, 27061.59407608927, 29584.704152958195, 29739.0, 30175.698243018167, 30774.197072860534, 22514.98682559256, 22609.0, 22804.087836486353, 23044.539109217385, 23075.0], "value": 18895.35979248015, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.0724313164209, 368.3682484539016, 370.5275773388928, 389.12641120684066, 417.0595307581405, 13587.592372228837, 14016.789748153773, 14515.85484145157, 20359.0, 20854.791452085476, 20480.89759551204, 20936.581268374623, 21434.678479822815, 21967.0, 21981.450463738416, 5621.887562248773, 5762.250907382045, 6009.549283803733, 6022.789202377918, 6028.788992385267, 5918.408159184069, 6041.124037014631, 6066.848328791772, 6068.241469816273, 6083.057126145432, 2955.2316397736636, 3751.362268414376, 5133.794648214067, 5996.790112346069, 6065.302490213616, 5234.5027222414, 6071.817845464599, 6081.604695694788, 6088.878222435571, 6115.296740874812, 5191.169412893956, 5427.728613569345, 5484.177373393983, 5512.283403157604, 5543.6396634218645, 13310.800337994939, 13423.463061477529, 13455.259960702157, 13503.392347344394, 13657.590272291847, 2449.669294645218, 2475.517274131545, 2484.503099380131, 2532.8733563321944, 2546.401595625027, 9793.755156121082, 14294.64263393413, 14432.278386080654, 14704.117752934751, 15451.690966180613, 1710.8802383833136, 1773.5388798912247, 1786.883852549593, 1810.6921823290072, 1834.4588346437833, 106029.0, 109684.9999999992, 124600.37699811533, 131740.99999999904, 134360.0, 10857.51141198648, 10863.0, 11395.943020284845, 11613.535458581562, 12013.176903427688, 15372.077675339515, 15372.385104595915, 15397.846021539865, 15416.768748468781, 15427.291901996334, 8042.959785201154, 8242.917570824335, 8247.670093196204, 8423.452475589189, 8454.746357609281, 7585.355244804143, 7644.617769111522, 7873.881891771628, 8027.357811375076, 8213.917860821435, 3774.7168962327937, 4611.354410382549, 4641.535846415399, 4663.592904705021, 4737.786799594027, 1987.8012198780295, 1999.850011249133, 2002.2191345375315, 2013.4865609269837, 2021.6462119129094, 812.6668066092874, 951.5004622573205, 978.8287049766262, 991.7074463033423, 1024.3802499487851, 19897.403077907686, 20440.933859920835, 21099.578008439745, 21187.0, 21321.573568528544, 947.5877993073035, 988.584794386345, 994.8906968729814, 1047.5652604169336, 1052.5789684126257, 10285.948570257251, 10840.837387439195, 10939.617113400993, 11102.056325212447, 11143.33140011602, 487282.5635871798, 553062.0, 565571.0, 571159.0, 574639.0, 126258.0, 127101.0, 130538.0, 130925.0, 132401.0, 898.8786513820681, 935.9096652400013, 1030.644427672452, 1044.1072882685346, 1047.3867700088176, 18813.247470101043, 19775.901120494305, 19800.504987375432, 19851.801481984996, 19895.502612434804, 50739.74630126826, 50960.572294125705, 56494.0, 56908.86182276414, 57725.422745772004, 71308.45272134704, 71982.0, 73311.0, 75352.81325768078, 75369.0, 7269.781906542812, 8126.918730812617, 8142.068855212, 8437.578121094044, 8547.487150770974, 8906.643734250816, 10838.945805271238, 12981.740365192833, 13336.599902002956, 13454.798178027533, 11241.213115081866, 11346.773064538498, 11451.656450306504, 11580.363080030342, 11642.068634509389, 10848.240623156618, 11094.833577496505, 11180.273282236629, 11205.0, 11307.0, 11391.601293954673, 11429.828552571551, 11621.302721836717, 11649.1263155262, 11773.234739741889, 8015.599220038858, 8056.879146812919, 8536.658533658585, 8549.786255343666, 8620.03478399943, 9244.907550924405, 9806.264530160124, 10399.84400233982, 11520.308781473139, 11551.942240289081], "value": 9415.319325590424, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.2484707951864, 1447.7176950494659, 1459.890508211884, 1471.5144002479183, 1480.4078368652538, 7270.96364518178, 7276.272372762721, 8155.959220203898, 8575.356848236375, 8589.35579831512, 8194.426390152677, 8459.830803383944, 8463.492190468576, 8599.699010534632, 8615.43999640023, 2239.8656080635174, 2265.2184996176375, 2277.555876604063, 2277.7266727992665, 2282.8085038363192, 2253.3690566641367, 2289.0386037864137, 2290.2213247495847, 2291.5073259249257, 2292.5529521743265, 2243.3157886844506, 2244.898979545916, 2271.5343354612264, 2274.363178310076, 2276.7381751098587, 1881.811818818114, 2184.650455927044, 2192.199847055829, 2226.309843948365, 2234.6201145805253, 2172.2180015194517, 2234.6648002799548, 2239.317008312464, 2240.305505293364, 2241.8991145398495, 8471.534065626389, 8544.914550854473, 8547.230749232598, 8550.87173692389, 8564.61459234336, 5031.924521132186, 5181.0, 5212.582993360522, 5213.556847667953, 5223.085959956992, 2868.741813236819, 3184.5541624172633, 3251.463508521091, 3471.826408679581, 3475.1138459692615, 1171.6953592066125, 1178.3048001678965, 1214.502054157791, 1232.876712328769, 1242.198781785752, 9996.700098997042, 10349.534270957825, 10358.43028633425, 10790.082842958358, 10852.348859068481, 3595.334863050344, 4390.538993405647, 4394.802233899482, 4434.201843668106, 4442.20040392726, 8746.0, 8751.256143227769, 8752.69365572202, 8762.167594078552, 8784.385093043553, 4413.227685155085, 4553.977230113828, 4559.156556037144, 5093.159628661304, 5143.17709166539, 4612.538746125428, 4774.331593576902, 4817.735024573612, 4838.250071238964, 4853.053654537332, 3377.560917080813, 3551.804650744234, 3561.7684850484634, 3626.220362621996, 3647.76289541179, 1116.3636727065657, 1118.2675347647305, 1126.7829551721238, 1134.5802053240354, 1137.9829302560468, 746.8692978728809, 865.6450855149484, 879.560219890055, 886.5655828644047, 899.6311512280065, 5275.261463395128, 5576.776928922797, 5761.3991255465335, 5783.450572195635, 5953.880922381615, 916.9908300917039, 933.4725879877848, 953.7663272498144, 954.5656726189567, 956.7368973532195, 3512.1570823002808, 3552.946705799415, 3580.5166302548823, 3615.0, 3686.760360576554, 8809.647614095493, 9558.996305387835, 9696.854547181798, 10035.147012503872, 10054.245931555162, 9939.701808945743, 9953.303268771117, 9990.252680512916, 9994.10053095225, 10007.09936105754, 7252.202257751643, 7476.626168691544, 7598.164201937782, 7621.894825250308, 7644.732434364882, 5313.229581710708, 5537.640053396516, 5656.377798442086, 5691.203231547669, 5731.054376027909, 8666.436681615674, 8702.47785132894, 8712.21590056898, 9009.954950225207, 9296.488693121943, 8313.12712165214, 8363.790905227417, 8575.356848236283, 8649.437786543855, 9226.584803683716, 6990.545614535039, 7126.35862772353, 7254.854902902018, 7267.418606511572, 7398.483310921356, 7827.373810095292, 8073.798155046171, 8076.0, 8080.83838323242, 8094.959525202572, 6964.930350696631, 7073.646317684198, 7073.82315442118, 7089.858202836018, 7179.676914538753, 6657.40083392497, 6692.866142677217, 6837.726490940307, 6912.135983002125, 6953.721851125898, 6099.512039036777, 6233.688315584293, 6349.333320001333, 6357.618542887441, 6378.585391949508, 4863.586595139453, 4890.975545122394, 4943.233798761198, 4944.8763780905765, 5053.36832895888, 4877.731724755031, 4901.730404827768, 4924.015196960694, 5010.49895010496, 5043.52086551777], "value": 4317.660829075965, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.8919994202116, 342.9794212347258, 361.28826212361656, 361.6889475051456, 363.2915814162384, 5278.841634750959, 5319.20211968205, 5327.8033180091925, 5344.465553444663, 5350.732463376826, 4344.7175933564295, 4602.930956035662, 4941.331680892323, 5148.48515148485, 5176.197689358146, 3835.61643835617, 3932.2725295820223, 3948.7689455457717, 3949.9605003950023, 3952.3281042222893, 3172.3662313908358, 3335.5997280326396, 3950.42718805773, 3963.7225394222414, 3974.225026119908, 3259.3807176636483, 3526.612072672004, 3532.664396882305, 3870.5355357357016, 3914.178022615254, 3230.56387387702, 3544.680978711928, 3861.0, 3931.0761970936805, 3944.132290896013, 3353.2455197580593, 3365.7980521168806, 3366.646502117291, 3368.696817286456, 3370.3764803511185, 4847.515248475124, 5011.223260394609, 5050.343455350818, 5063.54428101469, 5065.670731402447, 3539.4513850353237, 4116.732412393185, 4397.768624785033, 4431.734095954221, 4487.506374298824, 4902.921357301424, 5015.699058056528, 5057.595392368602, 5511.255980442629, 5531.9723401383135, 3555.6799888010205, 3709.7217708671956, 3725.3853114236117, 3734.5518537775642, 3751.0, 5546.0, 5802.752408232208, 5816.964062578106, 5827.35899051104, 5857.619254748428, 3787.7348585599293, 3792.544894612664, 3796.962030379661, 3801.790901500389, 3839.0978120142304, 3260.836958152083, 3482.791032538056, 3595.460680897886, 3856.9421458678144, 3862.787546684959, 3753.0242137044565, 3993.1813978134414, 3995.4805875236034, 4469.966165394738, 4506.904289505395, 4699.600533954652, 4863.443698016601, 5088.414832294259, 5461.678786515715, 5513.924784666951, 1134.3098782813713, 1143.3254379915722, 1147.8106112491346, 1234.4444999750149, 1268.35313989864, 743.271593838031, 772.5094564951296, 798.6406117247262, 827.3174630929507, 863.1756672377865, 4384.802683879169, 4385.846495372711, 4450.552196292027, 4653.6033942519625, 4881.4630390657, 4464.062546865194, 5094.592432605383, 5139.922901156486, 5415.508865921642, 5472.288602481732, 4304.139172165516, 4441.467023957146, 4593.04997701976, 4864.878378040577, 4882.658213925062, 2577.7497913511934, 2606.5699159638825, 2623.737626237361, 2743.684476285213, 2815.366542527915, 4621.722696638212, 5022.518357084668, 5522.751476183581, 5623.381428042912, 5687.118496633028, 4815.614750819926, 4892.287699305215, 5109.795608175706, 5579.860503487364, 5605.766731319103, 4829.46453112119, 4899.485554016848, 5149.6910185389, 5321.36143662763, 5677.290338707661, 4915.139850526072, 5398.46015398457, 5431.429699881455, 5443.863903402288, 5448.318960129984, 4919.877003074952, 5017.974910125426, 5105.33630628016, 5308.442613525524, 5382.246485492113, 5005.474425185449, 5213.0, 5373.9731301343245, 5587.870792356293, 5633.436656334334, 2989.402119576137, 3577.7495575309476, 3622.2755448910852, 3625.078708284613, 3632.927341453103, 4472.597466228055, 4858.7570621469495, 4888.535589119028, 4964.528369804862, 5158.337580317866, 4425.623821975039, 4834.341112388102, 5225.8122545248125, 5252.0, 5254.395744489279, 4731.645126615449, 4736.537000759517, 4933.076100320949, 5240.737963101906, 5271.4464981176425, 4496.932546011747, 4611.377464042445, 4866.343043689057, 4963.327137917842, 5094.2867998479505, 5233.685978841282, 5242.370915490165, 5261.447548007557, 5265.893642543014, 5274.208868669731, 4808.807647694053, 4842.927356089732, 4976.552110310089, 5129.230615407719, 5159.690418574897], "value": 3851.027414411928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.7390704578736, 710.9466789990748, 718.7412531488663, 754.5736658787785, 807.132332742302, 14049.578512644624, 14070.718585628281, 14385.136891786475, 14622.049566778165, 14631.122132672048, 13295.667608309797, 13485.865141348584, 13563.321833908314, 13724.176549407042, 13769.65575860604, 895.073598825216, 897.0670502677208, 897.4570384917129, 898.9146031127033, 904.9185573298402, 878.2578720980761, 906.4515967839461, 910.3036177324352, 910.5993362920327, 913.4701872913728, 974.4494360686225, 974.6247694637544, 975.4050029482011, 976.2921881635792, 977.5063592885583, 971.3443425687633, 972.023116767651, 972.0328273368044, 972.4408465132542, 973.0609961387224, 718.267367285366, 719.144218380126, 719.6186021408662, 720.9170945341248, 721.4841388407314, 14728.116313021254, 15159.393624255017, 15207.847921520754, 15245.237738113161, 15262.236888155549, 13632.93183534076, 13684.178949263076, 13817.170969741848, 13824.930875345659, 14011.64970875726, 11055.834162487568, 11084.556617735361, 11209.215354925158, 11401.0, 11719.0, 3617.5658920929395, 3653.2510835278704, 3743.794091324976, 3763.0216143802536, 3767.4348847672795, 88095.55952220262, 88321.0, 91022.1795564085, 92626.0, 93620.0, 10359.533820977924, 10371.222158338154, 10410.68767936963, 10463.319884207502, 10501.422421766723, 20194.798052019585, 21625.026873790717, 21801.0, 21899.67150492744, 21959.0, 7089.8884191558745, 7560.256632564657, 7598.506097103671, 7604.961975190088, 7680.769576912701, 4001.079751657135, 4107.979460102681, 4148.357004664282, 4159.251334759772, 4169.520505141887, 3421.349943510725, 3504.3867323218847, 3518.82405879705, 3521.031716278044, 3525.5945566259697, 643.7939859244997, 646.4505170604948, 649.9285078641345, 669.6819010969848, 669.8024082895557, 599.484443378694, 599.712138173679, 659.2747977225014, 664.4850241063118, 693.9236683964759, 9213.63145474187, 9306.348555601178, 9666.806663866684, 9680.370775899544, 9812.96963818803, 617.3795335687605, 625.7903602293283, 670.4368330602317, 679.2785388580071, 725.2167658928345, 4245.957540424618, 4688.437387513521, 4689.1559519286175, 4700.130475861976, 4774.2599897015325, 76730.6163469179, 90758.63862042075, 95870.0, 96172.14835549307, 98034.50982745041, 80842.59578702069, 82155.5892220535, 83149.0, 83181.16818831855, 86750.56624716836, 63952.0, 72233.0, 74253.0, 74428.25571744321, 76307.61846190733, 9088.863667045132, 9135.543222838964, 9137.862932056158, 9240.306976976619, 9246.583903724482, 41852.790736046125, 43266.0, 43657.69026929197, 47156.76421618007, 47356.0, 60223.69888150531, 62389.0, 62441.687791560755, 62858.0, 64552.67723661352, 12321.753564928831, 12568.74862502763, 12585.181963172365, 13011.934940325238, 13112.803307950198, 11903.702407439883, 13833.654158646114, 13872.306384680523, 13939.581812545639, 14027.649308767363, 12884.0, 12999.805002924775, 13032.934835325763, 13051.28217948022, 13083.280419577015, 12613.936930315289, 12772.361381930681, 12981.228125994152, 13100.934495327463, 13176.341182940623, 12542.623721288375, 12560.74878502443, 12825.294608796607, 12866.485340586272, 13569.0, 9479.176492198332, 9905.306628535933, 10042.246831487813, 10224.488775561342, 10382.636607718694, 10019.499025048864, 10230.0, 10246.322017352912, 10342.32774869631, 10412.114970227616], "value": 7266.604507999845, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1504.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0, 113.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 112.0, 110.0, 154.0, 111.0, 122.0, 112.0, 112.0, 134.0, 112.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 186.0, 189.0, 185.0, 183.0, 181.0, 186.0, 184.0, 185.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 61.0, 92.0, 64.0, 59.0, 61.0, 62.0, 77.0, 62.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 86.0, 69.0, 72.0, 71.0, 87.0, 69.0, 81.0, 116.0], "value": 81.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 92.0, 90.0, 90.0, 91.0, 91.0, 90.0, 91.0, 91.0], "value": 90.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 110.0, 151.0, 149.0, 97.0, 99.0, 98.0, 97.0, 102.0], "value": 109.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 84.0, 88.0, 86.0, 88.0, 87.0, 86.0, 85.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 60.0, 61.0, 60.0, 60.0, 62.0, 59.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 73.0, 83.0, 77.0, 72.0, 72.0, 70.0, 70.0, 70.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 93.0, 93.0, 94.0, 94.0, 98.0, 97.0, 115.0, 114.0], "value": 98.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 168.0, 156.0, 156.0, 132.0, 146.0, 148.0, 146.0, 191.0, 164.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 183.0, 185.0, 184.0, 188.0, 213.0, 182.0, 186.0, 184.0], "value": 187.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 86.0, 86.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0], "value": 71.3, "unit": "score"}]}]} 06:08:37 INFO - Return code: 0 06:08:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:08:37 ERROR - # TBPL SUCCESS # 06:08:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:08:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:08:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:08:37 INFO - 2017-03-13 06:08:37.178 screenresolution[2993:36165] starting screenresolution argv=screenresolution get 06:08:37 INFO - 2017-03-13 06:08:37.181 screenresolution[2993:36165] Display 0: 1600x1200x32@60 06:08:37 INFO - 2017-03-13 06:08:37.187 screenresolution[2994:36168] starting screenresolution argv=screenresolution list 06:08:37 INFO - Available Modes on Display 0 06:08:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:08:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:08:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:08:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:08:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:08:37 INFO - Intel Iris: 06:08:37 INFO - Chipset Model: Intel Iris 06:08:37 INFO - Type: GPU 06:08:37 INFO - Bus: Built-In 06:08:37 INFO - VRAM (Dynamic, Max): 1536 MB 06:08:37 INFO - Vendor: Intel (0x8086) 06:08:37 INFO - Device ID: 0x0a2e 06:08:37 INFO - Revision ID: 0x0009 06:08:37 INFO - Displays: 06:08:37 INFO - Display: 06:08:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:08:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:08:37 INFO - Display Serial Number: 1600x1200 60 06:08:37 INFO - Main Display: Yes 06:08:37 INFO - Mirror: Off 06:08:37 INFO - Online: Yes 06:08:37 INFO - Rotation: Supported 06:08:37 INFO - Return code: 0 06:08:37 INFO - Running post-action listener: _resource_record_post_action 06:08:37 INFO - [mozharness: 2017-03-13 13:08:37.424361Z] Finished run-tests step (success) 06:08:37 INFO - Running post-run listener: _resource_record_post_run 06:08:37 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 0; Write bytes: 556535296; Read time: 0; Write time: 1667 06:08:37 INFO - TinderboxPrint: CPU usage
53.8% 06:08:37 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:08:37 INFO - TinderboxPrint: I/O write bytes / time
556,535,296 / 1,667 06:08:37 INFO - TinderboxPrint: CPU idle
2,225.2 (46.2%) 06:08:37 INFO - TinderboxPrint: CPU system
964.5 (20.0%) 06:08:37 INFO - TinderboxPrint: CPU user
1,627.8 (33.8%) 06:08:37 INFO - TinderboxPrint: Swap in / out
251,977,728 / 0 06:08:37 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 246696448; Write bytes: 242153472; Read time: 18516; Write time: 516 06:08:37 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 0; Write bytes: 299017728; Read time: 0; Write time: 1108 06:08:37 INFO - Running post-run listener: _upload_blobber_files 06:08:37 INFO - Blob upload gear active. 06:08:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:08:37 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 06:08:37 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'] 06:08:37 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 06:08:38 INFO - (blobuploader) - INFO - Open directory for files ... 06:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:39 INFO - (blobuploader) - INFO - Done attempting. 06:08:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:08:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:40 INFO - (blobuploader) - INFO - Done attempting. 06:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:41 INFO - (blobuploader) - INFO - Done attempting. 06:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:08:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:08:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:43 INFO - (blobuploader) - INFO - Done attempting. 06:08:43 INFO - (blobuploader) - INFO - Iteration through files over. 06:08:43 INFO - Return code: 0 06:08:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:08:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:08:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00bbff5c0e7b552197e88c81fad69ab012ae22c1d950abb09f36ae174275a84ca68a46d7cff95e8e7c4d0845beba49b86f7b2917103c95d240d0475e79459f14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9125eed46d4da1300de5e1718b34e7bc8ed631d2c50ee6eb74c9e506370fef17f75f837144e88a591e5f98f6edb368171e193fc8db67830b7622fa2b1bc69191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fd200ecddd79f48a08bb3e4ea864772e809fae9de772dc02fe9b6d5a69fd20cd7c12b977b1021ada177bb831ba59786e9041fb2916780702420a3f4c7e73bcf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a65ae5757ec32307e6ef59d394ff1afe92e26969f88bbd1fbc9335016e3082c2268a4bd1e9138d7e666ab2a8f6797772b5d2484404615d98f0002bf8c08bb72d"} 06:08:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:08:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:08:43 INFO - Contents: 06:08:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00bbff5c0e7b552197e88c81fad69ab012ae22c1d950abb09f36ae174275a84ca68a46d7cff95e8e7c4d0845beba49b86f7b2917103c95d240d0475e79459f14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9125eed46d4da1300de5e1718b34e7bc8ed631d2c50ee6eb74c9e506370fef17f75f837144e88a591e5f98f6edb368171e193fc8db67830b7622fa2b1bc69191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fd200ecddd79f48a08bb3e4ea864772e809fae9de772dc02fe9b6d5a69fd20cd7c12b977b1021ada177bb831ba59786e9041fb2916780702420a3f4c7e73bcf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a65ae5757ec32307e6ef59d394ff1afe92e26969f88bbd1fbc9335016e3082c2268a4bd1e9138d7e666ab2a8f6797772b5d2484404615d98f0002bf8c08bb72d"} 06:08:43 INFO - Running post-run listener: copy_logs_to_upload_dir 06:08:43 INFO - Copying logs to upload dir... 06:08:43 INFO - mkdir: /builds/slave/test/build/upload/logs 06:08:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.435818 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-13 06:08:44.006831) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 06:08:44.010661) ========= 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.h1L6zBv8WM/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.bsntF2ImYk/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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/00bbff5c0e7b552197e88c81fad69ab012ae22c1d950abb09f36ae174275a84ca68a46d7cff95e8e7c4d0845beba49b86f7b2917103c95d240d0475e79459f14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9125eed46d4da1300de5e1718b34e7bc8ed631d2c50ee6eb74c9e506370fef17f75f837144e88a591e5f98f6edb368171e193fc8db67830b7622fa2b1bc69191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fd200ecddd79f48a08bb3e4ea864772e809fae9de772dc02fe9b6d5a69fd20cd7c12b977b1021ada177bb831ba59786e9041fb2916780702420a3f4c7e73bcf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a65ae5757ec32307e6ef59d394ff1afe92e26969f88bbd1fbc9335016e3082c2268a4bd1e9138d7e666ab2a8f6797772b5d2484404615d98f0002bf8c08bb72d"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00bbff5c0e7b552197e88c81fad69ab012ae22c1d950abb09f36ae174275a84ca68a46d7cff95e8e7c4d0845beba49b86f7b2917103c95d240d0475e79459f14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9125eed46d4da1300de5e1718b34e7bc8ed631d2c50ee6eb74c9e506370fef17f75f837144e88a591e5f98f6edb368171e193fc8db67830b7622fa2b1bc69191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fd200ecddd79f48a08bb3e4ea864772e809fae9de772dc02fe9b6d5a69fd20cd7c12b977b1021ada177bb831ba59786e9041fb2916780702420a3f4c7e73bcf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a65ae5757ec32307e6ef59d394ff1afe92e26969f88bbd1fbc9335016e3082c2268a4bd1e9138d7e666ab2a8f6797772b5d2484404615d98f0002bf8c08bb72d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 06:08:44.050172) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 06:08:44.050974) ========= 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.h1L6zBv8WM/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.bsntF2ImYk/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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.005202 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 06:08:44.103426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 06:08:44.104037) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 06:08:44.104878) ========= ========= Total master_lag: 0.19 =========