builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0368 starttime: 1488866381.33 results: success (0) buildid: 20170306215927 builduid: 472464cc992045d48da6fa3477c8433b revision: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-06 21:59:41.328709) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-06 21:59:41.329128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-06 21:59:41.329399) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-06 21:59:41.355548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 21:59:41.355842) ========= 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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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-06 21:59:41-- 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% 36.1M=0s 2017-03-06 21:59:41 (36.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130506 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 21:59:41.510289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 21:59:41.510606) ========= 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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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.025774 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 21:59:41.559651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-06 21:59:41.559998) ========= 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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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-06 21:59:41,667 truncating revision to first 12 chars 2017-03-06 21:59:41,667 Setting DEBUG logging. 2017-03-06 21:59:41,667 attempt 1/10 2017-03-06 21:59:41,667 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-06 21:59:43,453 unpacking tar archive at: mozilla-central-fc9f6f7e8e86/testing/mozharness/ program finished with exit code 0 elapsedTime=2.060337 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-06 21:59:43.642324) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-06 21:59:43.643077) ========= script_repo_revision: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-06 21:59:43.643494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-06 21:59:43.643774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-06 21:59:43.667012) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2017-03-06 21:59:43.667301) ========= /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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 21:59:43 INFO - MultiFileLogger online at 20170306 21:59:43 in /builds/slave/test 21:59:43 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 21:59:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:59:43 INFO - {'append_to_log': False, 21:59:43 INFO - 'base_work_dir': '/builds/slave/test', 21:59:43 INFO - 'blob_upload_branch': 'Firefox', 21:59:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:59:43 INFO - 'branch': 'Firefox', 21:59:43 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:43 INFO - 'config_files': ('talos/mac_config.py',), 21:59:43 INFO - 'default_actions': ('clobber', 21:59:43 INFO - 'read-buildbot-config', 21:59:43 INFO - 'download-and-extract', 21:59:43 INFO - 'populate-webroot', 21:59:43 INFO - 'create-virtualenv', 21:59:43 INFO - 'install', 21:59:43 INFO - 'run-tests'), 21:59:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:43 INFO - 'download_minidump_stackwalk': True, 21:59:43 INFO - 'download_symbols': 'ondemand', 21:59:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:43 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:43 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:43 INFO - 'installer_path': 'installer.exe', 21:59:43 INFO - 'log_level': 'info', 21:59:43 INFO - 'log_name': 'talos', 21:59:43 INFO - 'log_to_console': True, 21:59:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:59:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:59:43 INFO - 'opt_config_files': (), 21:59:43 INFO - 'pip_index': False, 21:59:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:59:43 INFO - 'cmd': ('bash', 21:59:43 INFO - '-c', 21:59:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:59:43 INFO - 'enabled': True, 21:59:43 INFO - 'halt_on_failure': False, 21:59:43 INFO - 'name': 'check_screen_resolution'},), 21:59:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:59:43 INFO - 'cmd': ('bash', 21:59:43 INFO - '-c', 21:59:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:59:43 INFO - 'enabled': True, 21:59:43 INFO - 'halt_on_failure': False, 21:59:43 INFO - 'name': 'check_screen_resolution'},), 21:59:43 INFO - 'run_cmd_checks_enabled': True, 21:59:43 INFO - 'sps_profile': False, 21:59:43 INFO - 'sps_profile_interval': 0, 21:59:43 INFO - 'suite': 'dromaeojs', 21:59:43 INFO - 'system_bits': '32', 21:59:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:43 INFO - 'title': 't-yosemite-r7-0368', 21:59:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:43 INFO - 'use_talos_json': True, 21:59:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:59:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:43 INFO - 'work_dir': 'build'} 21:59:43 INFO - [mozharness: 2017-03-07 05:59:43.869115Z] Running clobber step. 21:59:43 INFO - Running pre-action listener: _resource_record_pre_action 21:59:43 INFO - Running main action method: clobber 21:59:43 INFO - rmtree: /builds/slave/test/build 21:59:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:59:46 INFO - Running post-action listener: _resource_record_post_action 21:59:46 INFO - [mozharness: 2017-03-07 05:59:46.203549Z] Finished clobber step (success) 21:59:46 INFO - [mozharness: 2017-03-07 05:59:46.203674Z] Running read-buildbot-config step. 21:59:46 INFO - Running pre-action listener: _resource_record_pre_action 21:59:46 INFO - Running main action method: read_buildbot_config 21:59:46 INFO - Using buildbot properties: 21:59:46 INFO - { 21:59:46 INFO - "project": "", 21:59:46 INFO - "product": "firefox", 21:59:46 INFO - "script_repo_revision": "production", 21:59:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:59:46 INFO - "repository": "", 21:59:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:59:46 INFO - "buildid": "20170306215927", 21:59:46 INFO - "stage_platform": "macosx64", 21:59:46 INFO - "basedir": "/builds/slave/test", 21:59:46 INFO - "buildnumber": 12, 21:59:46 INFO - "platform": "yosemite_r7", 21:59:46 INFO - "mozci_request": { 21:59:46 INFO - "priority": -1, 21:59:46 INFO - "type": "trigger_all_talos_jobs", 21:59:46 INFO - "times": 1 21:59:46 INFO - }, 21:59:46 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 21:59:46 INFO - "slavebuilddir": "test", 21:59:46 INFO - "branch": "mozilla-central", 21:59:46 INFO - "revision": "fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd", 21:59:46 INFO - "slavename": "t-yosemite-r7-0368", 21:59:46 INFO - "builduid": "472464cc992045d48da6fa3477c8433b", 21:59:46 INFO - "repo_path": "mozilla-central" 21:59:46 INFO - } 21:59:46 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg. 21:59:46 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. 21:59:46 INFO - Running post-action listener: _resource_record_post_action 21:59:46 INFO - [mozharness: 2017-03-07 05:59:46.207528Z] Finished read-buildbot-config step (success) 21:59:46 INFO - [mozharness: 2017-03-07 05:59:46.207661Z] Running download-and-extract step. 21:59:46 INFO - Running pre-action listener: _resource_record_pre_action 21:59:46 INFO - Running main action method: download_and_extract 21:59:46 INFO - mkdir: /builds/slave/test/build/tests 21:59:46 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')]} 21:59:46 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json 21:59:46 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 21:59:46 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 21:59:46 INFO - Downloaded 1199 bytes. 21:59:46 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 21:59:46 INFO - Using the following test package requirements: 21:59:46 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 21:59:46 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 21:59:46 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 21:59:46 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 21:59:46 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 21:59:46 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 21:59:46 INFO - u'jsshell-mac.zip'], 21:59:46 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 21:59:46 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 21:59:46 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 21:59:46 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 21:59:46 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 21:59:46 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 21:59:46 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 21:59:46 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 21:59:46 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 21:59:46 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 21:59:46 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 21:59:46 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:59:46 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 21:59:46 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 21:59:46 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 21:59:49 INFO - Expected file size: 51504348 21:59:49 INFO - Obtained file size: 51504348 22:00:05 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 22:00:05 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 22:00:05 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 22:00:05 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 22:00:06 INFO - Expected file size: 51504348 22:00:06 INFO - Obtained file size: 51504348 22:00:21 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 22:00:21 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 22:00:21 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 22:00:25 INFO - Expected file size: 14403647 22:00:25 INFO - Obtained file size: 14403647 22:00:25 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')]} 22:00:25 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 22:00:25 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 22:00:25 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 22:00:31 INFO - Downloaded 70417704 bytes. 22:00:31 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 22:00:31 INFO - mkdir: /builds/slave/test/properties 22:00:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:00:31 INFO - Writing to file /builds/slave/test/properties/build_url 22:00:31 INFO - Contents: 22:00:31 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 22:00:32 INFO - Running post-action listener: _resource_record_post_action 22:00:32 INFO - Running post-action listener: set_extra_try_arguments 22:00:32 INFO - [mozharness: 2017-03-07 06:00:32.094228Z] Finished download-and-extract step (success) 22:00:32 INFO - [mozharness: 2017-03-07 06:00:32.094355Z] Running populate-webroot step. 22:00:32 INFO - Running pre-action listener: _resource_record_pre_action 22:00:32 INFO - Running main action method: populate_webroot 22:00:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:00:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:00:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:00:32 INFO - '--tppagecycles', 22:00:32 INFO - '7'], 22:00:32 INFO - 'tests': ['tsvgm']}}, 22:00:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:00:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:00:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:00:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:00:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:00:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:00:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:00:32 INFO - 'talos_options': ['--disable-e10s'], 22:00:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:00:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:00:32 INFO - 'talos_options': ['--disable-e10s'], 22:00:32 INFO - 'tests': ['damp', 'tps']}, 22:00:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:00:32 INFO - 'tests': ['damp', 'tps']}, 22:00:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:00:32 INFO - 'tests': ['dromaeo_dom']}, 22:00:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:00:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:00:32 INFO - 'tests': ['basic_compositor_video']}, 22:00:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:00:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:00:32 INFO - 'tests': ['a11yr', 22:00:32 INFO - 'ts_paint', 22:00:32 INFO - 'tpaint', 22:00:32 INFO - 'sessionrestore', 22:00:32 INFO - 'sessionrestore_no_auto_restore', 22:00:32 INFO - 'tabpaint']}, 22:00:32 INFO - 'other-e10s': {'tests': ['a11yr', 22:00:32 INFO - 'ts_paint', 22:00:32 INFO - 'tpaint', 22:00:32 INFO - 'sessionrestore', 22:00:32 INFO - 'sessionrestore_no_auto_restore', 22:00:32 INFO - 'tabpaint']}, 22:00:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:00:32 INFO - 'ts_paint', 22:00:32 INFO - 'tpaint', 22:00:32 INFO - 'sessionrestore', 22:00:32 INFO - 'sessionrestore_no_auto_restore', 22:00:32 INFO - 'tabpaint']}, 22:00:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:00:32 INFO - 'ts_paint', 22:00:32 INFO - 'tpaint', 22:00:32 INFO - 'sessionrestore', 22:00:32 INFO - 'sessionrestore_no_auto_restore', 22:00:32 INFO - 'tabpaint']}, 22:00:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:00:32 INFO - 'tests': ['a11yr', 22:00:32 INFO - 'ts_paint', 22:00:32 INFO - 'tpaint', 22:00:32 INFO - 'sessionrestore', 22:00:32 INFO - 'sessionrestore_no_auto_restore', 22:00:32 INFO - 'tabpaint']}, 22:00:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:00:32 INFO - 'tests': ['a11yr', 22:00:32 INFO - 'ts_paint', 22:00:32 INFO - 'tpaint', 22:00:32 INFO - 'sessionrestore', 22:00:32 INFO - 'sessionrestore_no_auto_restore', 22:00:32 INFO - 'tabpaint']}, 22:00:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:00:32 INFO - 'tests': ['tsvgx', 22:00:32 INFO - 'tsvgr_opacity', 22:00:32 INFO - 'tart', 22:00:32 INFO - 'tscrollx', 22:00:32 INFO - 'cart', 22:00:32 INFO - 'tsvg_static']}, 22:00:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:00:32 INFO - 'tsvgr_opacity', 22:00:32 INFO - 'tart', 22:00:32 INFO - 'tscrollx', 22:00:32 INFO - 'cart', 22:00:32 INFO - 'tsvg_static']}, 22:00:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:00:32 INFO - 'talos_options': ['--disable-e10s'], 22:00:32 INFO - 'tests': ['tp5o']}, 22:00:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:00:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:00:32 INFO - 'talos_options': ['--disable-e10s', 22:00:32 INFO - '--xperf_path', 22:00:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:32 INFO - 'tests': ['tp5n']}, 22:00:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:00:32 INFO - 'talos_options': ['--xperf_path', 22:00:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:32 INFO - 'tests': ['tp5n']}}, 22:00:32 INFO - 'talos.zip': {'path': '', 22:00:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:00:32 INFO - Running post-action listener: _resource_record_post_action 22:00:32 INFO - [mozharness: 2017-03-07 06:00:32.112674Z] Finished populate-webroot step (success) 22:00:32 INFO - [mozharness: 2017-03-07 06:00:32.112785Z] Running create-virtualenv step. 22:00:32 INFO - Running pre-action listener: _resource_record_pre_action 22:00:32 INFO - Running main action method: create_virtualenv 22:00:32 INFO - Creating virtualenv /builds/slave/test/build/venv 22:00:32 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 22:00:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:00:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:00:32 INFO - Using real prefix '/tools/python27' 22:00:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:00:32 INFO - Installing distribute.............................................................................................................................................................................................done. 22:00:35 INFO - Installing pip.................done. 22:00:35 INFO - Return code: 0 22:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:00:36 INFO - Reading from file tmpfile_stdout 22:00:36 INFO - Output received: 22:00:36 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) 22:00:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:00:36 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')]} 22:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:36 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')]} 22:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:36 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 0x101274b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101277768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb8cd6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101052d30>, '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 0x100f79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101047be8>, '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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 22:00:36 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 22:00:36 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 22:00:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZnnrJc5aZs/Render', 22:00:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:36 INFO - 'HOME': '/Users/cltbld', 22:00:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:36 INFO - 'LOGNAME': 'cltbld', 22:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:36 INFO - 'MOZ_NO_REMOTE': '1', 22:00:36 INFO - 'NO_EM_RESTART': '1', 22:00:36 INFO - 'PAGER': '/bin/cat', 22:00:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:36 INFO - 'PWD': '/builds/slave/test', 22:00:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:36 INFO - 'SHELL': '/bin/bash', 22:00:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQn0NHFVg2/Listeners', 22:00:36 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 22:00:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:36 INFO - 'USER': 'cltbld', 22:00:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:36 INFO - 'XPC_FLAGS': '0x0', 22:00:36 INFO - 'XPC_SERVICE_NAME': '0', 22:00:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:37 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 22:00:37 INFO - Cleaning up... 22:00:37 INFO - Return code: 0 22:00:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101274b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101277768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb8cd6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101052d30>, '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 0x100f79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101047be8>, '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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 22:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:00:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZnnrJc5aZs/Render', 22:00:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:37 INFO - 'HOME': '/Users/cltbld', 22:00:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:37 INFO - 'LOGNAME': 'cltbld', 22:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:37 INFO - 'MOZ_NO_REMOTE': '1', 22:00:37 INFO - 'NO_EM_RESTART': '1', 22:00:37 INFO - 'PAGER': '/bin/cat', 22:00:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:37 INFO - 'PWD': '/builds/slave/test', 22:00:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:37 INFO - 'SHELL': '/bin/bash', 22:00:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQn0NHFVg2/Listeners', 22:00:37 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 22:00:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:37 INFO - 'USER': 'cltbld', 22:00:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:37 INFO - 'XPC_FLAGS': '0x0', 22:00:37 INFO - 'XPC_SERVICE_NAME': '0', 22:00:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:37 INFO - Downloading/unpacking psutil>=3.1.1 22:00:37 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 22:00:37 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 22:00:37 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 22:00:37 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 22:00:37 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 22:00:37 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 22:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:00:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:41 INFO - Installing collected packages: psutil 22:00:41 INFO - Running setup.py install for psutil 22:00:41 INFO - building 'psutil._psutil_osx' extension 22:00:41 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 22:00:42 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 22:00:42 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 22:00:42 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 22:00:42 INFO - building 'psutil._psutil_posix' extension 22:00:42 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 22:00:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:00:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:00:42 INFO - ^ 22:00:42 INFO - 1 warning generated. 22:00:42 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 22:00:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:42 INFO - Successfully installed psutil 22:00:42 INFO - Cleaning up... 22:00:42 INFO - Return code: 0 22:00:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:42 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 0x101274b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101277768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb8cd6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101052d30>, '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 0x100f79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101047be8>, '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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 22:00:42 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 22:00:42 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 22:00:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZnnrJc5aZs/Render', 22:00:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:42 INFO - 'HOME': '/Users/cltbld', 22:00:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:42 INFO - 'LOGNAME': 'cltbld', 22:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:42 INFO - 'MOZ_NO_REMOTE': '1', 22:00:42 INFO - 'NO_EM_RESTART': '1', 22:00:42 INFO - 'PAGER': '/bin/cat', 22:00:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:42 INFO - 'PWD': '/builds/slave/test', 22:00:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:42 INFO - 'SHELL': '/bin/bash', 22:00:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQn0NHFVg2/Listeners', 22:00:42 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 22:00:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:42 INFO - 'USER': 'cltbld', 22:00:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:42 INFO - 'XPC_FLAGS': '0x0', 22:00:42 INFO - 'XPC_SERVICE_NAME': '0', 22:00:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:00:43 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 22:00:43 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 22:00:43 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 22:00:43 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 22:00:43 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 22:00:43 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 22:00:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:00:45 INFO - Installing collected packages: mozsystemmonitor 22:00:45 INFO - Running setup.py install for mozsystemmonitor 22:00:46 INFO - Successfully installed mozsystemmonitor 22:00:46 INFO - Cleaning up... 22:00:46 INFO - Return code: 0 22:00:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:00:46 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')]} 22:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:46 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')]} 22:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:46 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 0x101274b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101277768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb8cd6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101052d30>, '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 0x100f79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101047be8>, '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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 22:00:46 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 22:00:46 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 22:00:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZnnrJc5aZs/Render', 22:00:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:46 INFO - 'HOME': '/Users/cltbld', 22:00:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:46 INFO - 'LOGNAME': 'cltbld', 22:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:46 INFO - 'MOZ_NO_REMOTE': '1', 22:00:46 INFO - 'NO_EM_RESTART': '1', 22:00:46 INFO - 'PAGER': '/bin/cat', 22:00:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:46 INFO - 'PWD': '/builds/slave/test', 22:00:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:46 INFO - 'SHELL': '/bin/bash', 22:00:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQn0NHFVg2/Listeners', 22:00:46 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 22:00:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:46 INFO - 'USER': 'cltbld', 22:00:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:46 INFO - 'XPC_FLAGS': '0x0', 22:00:46 INFO - 'XPC_SERVICE_NAME': '0', 22:00:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:46 INFO - Downloading/unpacking jsonschema==2.5.1 22:00:46 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 22:00:46 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 22:00:46 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 22:00:46 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 22:00:46 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 22:00:46 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 22:00:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:49 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:49 INFO - warning: no files found matching '*.txt' 22:00:49 INFO - no previously-included directories found matching 'build' 22:00:49 INFO - no previously-included directories found matching 'dist' 22:00:49 INFO - no previously-included directories found matching '.git*' 22:00:49 INFO - Installing collected packages: jsonschema, functools32 22:00:49 INFO - Running setup.py install for functools32 22:00:49 INFO - warning: no files found matching '*.txt' 22:00:49 INFO - no previously-included directories found matching 'build' 22:00:49 INFO - no previously-included directories found matching 'dist' 22:00:49 INFO - no previously-included directories found matching '.git*' 22:00:49 INFO - Successfully installed jsonschema functools32 22:00:49 INFO - Cleaning up... 22:00:49 INFO - Return code: 0 22:00:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:00:49 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')]} 22:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:49 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')]} 22:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:49 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 0x101274b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101277768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb8cd6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101052d30>, '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 0x100f79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101047be8>, '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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 22:00:49 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 22:00:49 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 22:00:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZnnrJc5aZs/Render', 22:00:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:49 INFO - 'HOME': '/Users/cltbld', 22:00:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:49 INFO - 'LOGNAME': 'cltbld', 22:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:49 INFO - 'MOZ_NO_REMOTE': '1', 22:00:49 INFO - 'NO_EM_RESTART': '1', 22:00:49 INFO - 'PAGER': '/bin/cat', 22:00:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:49 INFO - 'PWD': '/builds/slave/test', 22:00:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:49 INFO - 'SHELL': '/bin/bash', 22:00:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQn0NHFVg2/Listeners', 22:00:49 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 22:00:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:49 INFO - 'USER': 'cltbld', 22:00:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:49 INFO - 'XPC_FLAGS': '0x0', 22:00:49 INFO - 'XPC_SERVICE_NAME': '0', 22:00:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:00:50 INFO - Cleaning up... 22:00:50 INFO - Return code: 0 22:00:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101274b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101277768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb8cd6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101052d30>, '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 0x100f79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101047be8>, '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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 22:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZnnrJc5aZs/Render', 22:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:50 INFO - 'HOME': '/Users/cltbld', 22:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:50 INFO - 'LOGNAME': 'cltbld', 22:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:50 INFO - 'MOZ_NO_REMOTE': '1', 22:00:50 INFO - 'NO_EM_RESTART': '1', 22:00:50 INFO - 'PAGER': '/bin/cat', 22:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:50 INFO - 'PWD': '/builds/slave/test', 22:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:50 INFO - 'SHELL': '/bin/bash', 22:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQn0NHFVg2/Listeners', 22:00:50 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 22:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:50 INFO - 'USER': 'cltbld', 22:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:50 INFO - 'XPC_FLAGS': '0x0', 22:00:50 INFO - 'XPC_SERVICE_NAME': '0', 22:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:50 INFO - Downloading/unpacking blobuploader==1.2.4 22:00:50 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 22:00:50 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 22:00:50 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 22:00:50 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 22:00:50 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 22:00:50 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 22:00:53 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:00:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:54 INFO - Downloading docopt-0.6.1.tar.gz 22:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:54 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:54 INFO - Running setup.py install for blobuploader 22:00:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:00:54 INFO - Running setup.py install for requests 22:00:55 INFO - Running setup.py install for docopt 22:00:55 INFO - Successfully installed blobuploader requests docopt 22:00:55 INFO - Cleaning up... 22:00:55 INFO - Return code: 0 22:00:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:55 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 0x101274b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101277768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb8cd6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101052d30>, '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 0x100f79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101047be8>, '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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 22:00:55 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 22:00:55 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 22:00:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZnnrJc5aZs/Render', 22:00:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:55 INFO - 'HOME': '/Users/cltbld', 22:00:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:55 INFO - 'LOGNAME': 'cltbld', 22:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:55 INFO - 'MOZ_NO_REMOTE': '1', 22:00:55 INFO - 'NO_EM_RESTART': '1', 22:00:55 INFO - 'PAGER': '/bin/cat', 22:00:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:55 INFO - 'PWD': '/builds/slave/test', 22:00:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:55 INFO - 'SHELL': '/bin/bash', 22:00:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQn0NHFVg2/Listeners', 22:00:55 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 22:00:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:55 INFO - 'USER': 'cltbld', 22:00:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:55 INFO - 'XPC_FLAGS': '0x0', 22:00:55 INFO - 'XPC_SERVICE_NAME': '0', 22:00:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:55 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-WV6Dmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:55 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-tYM0X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:55 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-JY12B6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:55 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-i9uSqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:56 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-YrSkru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:56 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-2zJ2gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:56 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-4CJH0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:56 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-CpBJML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:56 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-WmvJdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:56 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-x36wqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:56 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-2CdIxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:56 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-ZPmy5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:56 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-MQLN57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:56 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-ypw_JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:57 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-_Sz5WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:57 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-HPv4Bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:57 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-vF2eiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:57 INFO - Running setup.py install for manifestparser 22:00:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:00:57 INFO - Running setup.py install for mozcrash 22:00:57 INFO - Running setup.py install for mozdebug 22:00:57 INFO - Running setup.py install for mozdevice 22:00:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:00:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:00:57 INFO - Running setup.py install for mozfile 22:00:58 INFO - Running setup.py install for mozhttpd 22:00:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:00:58 INFO - Running setup.py install for mozinfo 22:00:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:00:58 INFO - Running setup.py install for mozInstall 22:00:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:00:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:00:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:00:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:00:58 INFO - Running setup.py install for mozleak 22:00:58 INFO - Running setup.py install for mozlog 22:00:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:00:58 INFO - Running setup.py install for moznetwork 22:00:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:00:58 INFO - Running setup.py install for mozprocess 22:00:59 INFO - Running setup.py install for mozprofile 22:00:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:00:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:00:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:00:59 INFO - Running setup.py install for mozrunner 22:00:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:00:59 INFO - Running setup.py install for mozscreenshot 22:00:59 INFO - Running setup.py install for moztest 22:00:59 INFO - Running setup.py install for mozversion 22:00:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:00:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:59 INFO - Cleaning up... 22:00:59 INFO - Return code: 0 22:00:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:59 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')]} 22:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:59 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')]} 22:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:59 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 0x101274b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101277768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb8cd6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101052d30>, '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 0x100f79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101047be8>, '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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 22:00:59 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 22:00:59 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 22:00:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZnnrJc5aZs/Render', 22:00:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:59 INFO - 'HOME': '/Users/cltbld', 22:00:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:59 INFO - 'LOGNAME': 'cltbld', 22:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:59 INFO - 'MOZ_NO_REMOTE': '1', 22:00:59 INFO - 'NO_EM_RESTART': '1', 22:00:59 INFO - 'PAGER': '/bin/cat', 22:00:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:59 INFO - 'PWD': '/builds/slave/test', 22:00:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:59 INFO - 'SHELL': '/bin/bash', 22:00:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQn0NHFVg2/Listeners', 22:00:59 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 22:00:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:59 INFO - 'USER': 'cltbld', 22:00:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:59 INFO - 'XPC_FLAGS': '0x0', 22:00:59 INFO - 'XPC_SERVICE_NAME': '0', 22:00:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:00 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-iBKvHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:00 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)) 22:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:00 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-0jIzYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:00 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)) 22:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:00 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-D1ato8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:00 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)) 22:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:00 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-lZsbTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:00 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)) 22:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:00 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-n7VjTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:00 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)) 22:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:00 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-kJQGGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01:00 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)) 22:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:00 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-ZgwP76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01:00 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)) 22:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:00 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-7tvbmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01:01 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:01 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-UZgAi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:01 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:01 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-H0sOin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:01 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:01 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-uTA7Sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:01 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:01 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-xbpWU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:01 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:01 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-cxVqWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:01 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:01 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-KsijdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:01 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:01 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-9twS0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:01 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:01 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-AnCRVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:01 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:01 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-peN6aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:02 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)) 22:01:02 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)) 22:01:02 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)) 22:01:02 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)) 22:01:02 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)) 22:01:02 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)) 22:01:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:01:02 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 22:01:02 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 22:01:02 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 22:01:02 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 22:01:02 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 22:01:02 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 22:01:04 INFO - Downloading blessings-1.6.tar.gz 22:01:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:01:04 INFO - Installing collected packages: blessings 22:01:04 INFO - Running setup.py install for blessings 22:01:04 INFO - Successfully installed blessings 22:01:04 INFO - Cleaning up... 22:01:04 INFO - Return code: 0 22:01:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:01:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:05 INFO - Reading from file tmpfile_stdout 22:01:05 INFO - Current package versions: 22:01:05 INFO - blessings == 1.6 22:01:05 INFO - blobuploader == 1.2.4 22:01:05 INFO - docopt == 0.6.1 22:01:05 INFO - functools32 == 3.2.3-2 22:01:05 INFO - jsonschema == 2.5.1 22:01:05 INFO - manifestparser == 1.1 22:01:05 INFO - mozInstall == 1.12 22:01:05 INFO - mozcrash == 1.0 22:01:05 INFO - mozdebug == 0.1 22:01:05 INFO - mozdevice == 0.49 22:01:05 INFO - mozfile == 1.2 22:01:05 INFO - mozhttpd == 0.7 22:01:05 INFO - mozinfo == 0.9 22:01:05 INFO - mozleak == 0.1 22:01:05 INFO - mozlog == 3.4 22:01:05 INFO - moznetwork == 0.27 22:01:05 INFO - mozprocess == 0.24 22:01:05 INFO - mozprofile == 0.28 22:01:05 INFO - mozrunner == 6.13 22:01:05 INFO - mozscreenshot == 0.1 22:01:05 INFO - mozsystemmonitor == 0.3 22:01:05 INFO - moztest == 0.8 22:01:05 INFO - mozversion == 1.4 22:01:05 INFO - psutil == 3.1.1 22:01:05 INFO - requests == 1.2.3 22:01:05 INFO - wsgiref == 0.1.2 22:01:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:05 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 0x101274b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101277768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb8cd6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101052d30>, '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 0x100f79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101047be8>, '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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 22:01:05 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 22:01:05 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 22:01:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZnnrJc5aZs/Render', 22:01:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:01:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:01:05 INFO - 'HOME': '/Users/cltbld', 22:01:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:01:05 INFO - 'LOGNAME': 'cltbld', 22:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:05 INFO - 'MOZ_NO_REMOTE': '1', 22:01:05 INFO - 'NO_EM_RESTART': '1', 22:01:05 INFO - 'PAGER': '/bin/cat', 22:01:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:05 INFO - 'PWD': '/builds/slave/test', 22:01:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:01:05 INFO - 'SHELL': '/bin/bash', 22:01:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQn0NHFVg2/Listeners', 22:01:05 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 22:01:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:01:05 INFO - 'USER': 'cltbld', 22:01:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:01:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:05 INFO - 'XPC_FLAGS': '0x0', 22:01:05 INFO - 'XPC_SERVICE_NAME': '0', 22:01:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 INFO - Cleaning up... 22:01:05 INFO - Return code: 0 22:01:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:05 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 0x101274b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101277768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb8cd6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101052d30>, '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 0x100f79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101047be8>, '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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 22:01:05 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 22:01:05 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 22:01:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZnnrJc5aZs/Render', 22:01:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:01:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:01:05 INFO - 'HOME': '/Users/cltbld', 22:01:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:01:05 INFO - 'LOGNAME': 'cltbld', 22:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:05 INFO - 'MOZ_NO_REMOTE': '1', 22:01:05 INFO - 'NO_EM_RESTART': '1', 22:01:05 INFO - 'PAGER': '/bin/cat', 22:01:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:05 INFO - 'PWD': '/builds/slave/test', 22:01:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:01:05 INFO - 'SHELL': '/bin/bash', 22:01:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQn0NHFVg2/Listeners', 22:01:05 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 22:01:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:01:05 INFO - 'USER': 'cltbld', 22:01:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:01:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:05 INFO - 'XPC_FLAGS': '0x0', 22:01:05 INFO - 'XPC_SERVICE_NAME': '0', 22:01:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:01:05 INFO - Cleaning up... 22:01:05 INFO - Return code: 0 22:01:05 INFO - Running post-action listener: _resource_record_post_action 22:01:05 INFO - Running post-action listener: _start_resource_monitoring 22:01:05 INFO - Starting resource monitoring. 22:01:05 INFO - [mozharness: 2017-03-07 06:01:05.815414Z] Finished create-virtualenv step (success) 22:01:05 INFO - [mozharness: 2017-03-07 06:01:05.816438Z] Running install step. 22:01:05 INFO - Running pre-action listener: _resource_record_pre_action 22:01:05 INFO - Running main action method: install 22:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:06 INFO - Reading from file tmpfile_stdout 22:01:06 INFO - Detecting whether we're running mozinstall >=1.0... 22:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:01:06 INFO - Reading from file tmpfile_stdout 22:01:06 INFO - Output received: 22:01:06 INFO - Usage: mozinstall [options] installer 22:01:06 INFO - Options: 22:01:06 INFO - -h, --help show this help message and exit 22:01:06 INFO - -d DEST, --destination=DEST 22:01:06 INFO - Directory to install application into. [default: 22:01:06 INFO - "/builds/slave/test"] 22:01:06 INFO - --app=APP Application being installed. [default: firefox] 22:01:06 INFO - mkdir: /builds/slave/test/build/application 22:01:06 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'] 22:01:06 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 22:01:28 INFO - Reading from file tmpfile_stdout 22:01:28 INFO - Output received: 22:01:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:01:28 INFO - Running post-action listener: _resource_record_post_action 22:01:28 INFO - [mozharness: 2017-03-07 06:01:28.688809Z] Finished install step (success) 22:01:28 INFO - [mozharness: 2017-03-07 06:01:28.688946Z] Running run-tests step. 22:01:28 INFO - Running pre-action listener: _resource_record_pre_action 22:01:28 INFO - Running main action method: run_tests 22:01:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:01:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:01:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:01:28 INFO - 2017-03-06 22:01:28.703 screenresolution[1628:7445] starting screenresolution argv=screenresolution get 22:01:28 INFO - 2017-03-06 22:01:28.706 screenresolution[1628:7445] Display 0: 1600x1200x32@60 22:01:28 INFO - 2017-03-06 22:01:28.712 screenresolution[1629:7447] starting screenresolution argv=screenresolution list 22:01:28 INFO - Available Modes on Display 0 22:01:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:01:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:01:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:01:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:01:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:01:28 INFO - Intel Iris: 22:01:28 INFO - Chipset Model: Intel Iris 22:01:28 INFO - Type: GPU 22:01:28 INFO - Bus: Built-In 22:01:28 INFO - VRAM (Dynamic, Max): 1536 MB 22:01:28 INFO - Vendor: Intel (0x8086) 22:01:28 INFO - Device ID: 0x0a2e 22:01:28 INFO - Revision ID: 0x0009 22:01:28 INFO - Displays: 22:01:28 INFO - Display: 22:01:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:01:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:01:28 INFO - Display Serial Number: 1600x1200 60 22:01:28 INFO - Main Display: Yes 22:01:28 INFO - Mirror: Off 22:01:28 INFO - Online: Yes 22:01:28 INFO - Rotation: Supported 22:01:28 INFO - Return code: 0 22:01:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:01:28 INFO - Python 2.7.3 22:01:28 INFO - Return code: 0 22:01:28 INFO - grabbing minidump binary from tooltool 22:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:28 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 0x101052d30>, '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 0x100f79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101047be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:01:28 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 22:01:28 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 22:01:28 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 22:01:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:01:29 INFO - Return code: 0 22:01:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:01:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:01:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:01:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:01:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:01:29 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-0368', '--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 22:01:29 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-0368 --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 22:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZnnrJc5aZs/Render', 22:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:01:29 INFO - 'HOME': '/Users/cltbld', 22:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:01:29 INFO - 'LOGNAME': 'cltbld', 22:01:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:01:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:29 INFO - 'MOZ_NO_REMOTE': '1', 22:01:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:01:29 INFO - 'NO_EM_RESTART': '1', 22:01:29 INFO - 'PAGER': '/bin/cat', 22:01:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:29 INFO - 'PWD': '/builds/slave/test', 22:01:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:01:29 INFO - 'SHELL': '/bin/bash', 22:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rQn0NHFVg2/Listeners', 22:01:29 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 22:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:01:29 INFO - 'USER': 'cltbld', 22:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:29 INFO - 'XPC_FLAGS': '0x0', 22:01:29 INFO - 'XPC_SERVICE_NAME': '0', 22:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:01:29 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-0368', '--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 22:01:29 INFO - mozversion application_buildid: 20170214071445 22:01:29 INFO - mozversion application_changeset: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd 22:01:29 INFO - mozversion application_display_name: Nightly 22:01:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:01:29 INFO - mozversion application_name: Firefox 22:01:29 INFO - mozversion application_remotingname: firefox 22:01:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:01:29 INFO - mozversion application_vendor: Mozilla 22:01:29 INFO - mozversion application_version: 54.0a1 22:01:29 INFO - mozversion platform_buildid: 20170214071445 22:01:29 INFO - mozversion platform_changeset: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd 22:01:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:01:29 INFO - mozversion platform_version: 54.0a1 22:01:29 INFO - using testdate: 1488866489 22:01:29 INFO - actual date: 1488866489 22:01:29 INFO - starting webserver on 'localhost:49241' 22:01:29 INFO - SUITE-START | Running 2 tests 22:01:29 INFO - TEST-START | dromaeo_css 22:01:29 INFO - operating with platform_type : mac_ 22:01:29 INFO - Initialising browser for dromaeo_css test... 22:01:29 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpyKvwiy/profile http://localhost:49241/getInfo.html) 22:01:31 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 22:01:31 INFO - PROCESS | 1639 | colorDepth:24 22:01:31 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 22:01:31 INFO - PROCESS | 1639 | __metrics 22:01:31 INFO - PROCESS | 1639 | 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" 22:01:31 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:01:32 INFO - TEST-INFO | 1639: exit 0 22:01:32 INFO - Browser initialized. 22:01:32 INFO - Running cycle 1/1 for dromaeo_css test... 22:01:32 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpyKvwiy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:44 INFO - PROCESS | 1641 | RSS: Main: 228990976 22:01:44 INFO - PROCESS | 1641 | 22:04:49 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 22:04:51 INFO - PROCESS | 1641 | RSS: Main: 387727360 22:04:51 INFO - PROCESS | 1641 | 22:06:34 INFO - PROCESS | 1641 | ************************* 22:06:34 INFO - PROCESS | 1641 | A coding exception was thrown and uncaught in a Task. 22:06:34 INFO - PROCESS | 1641 | 22:06:34 ERROR - PROCESS | 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:06:34 INFO - PROCESS | 1641 | Full stack: 22:06:34 INFO - PROCESS | 1641 | ************************* 22:07:54 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 22:07:54 INFO - PROCESS | 1641 | RSS: Main: 371412992 22:07:54 INFO - PROCESS | 1641 | 22:10:56 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 22:10:57 INFO - PROCESS | 1641 | RSS: Main: 368205824 22:10:57 INFO - PROCESS | 1641 | 22:14:00 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 22:14:00 INFO - PROCESS | 1641 | RSS: Main: 327507968 22:14:00 INFO - PROCESS | 1641 | 22:17:04 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 22:17:04 INFO - PROCESS | 1641 | RSS: Main: 329216000 22:17:04 INFO - PROCESS | 1641 | 22:20:08 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 22:20:08 INFO - PROCESS | 1641 | RSS: Main: 481898496 22:20:08 INFO - PROCESS | 1641 | 22:20:08 INFO - PROCESS | 1641 | __start_tp_report 22:20:08 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 22:20:08 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 22:20:08 INFO - PROCESS | 1641 | |i|pagename|runs| 22:20:08 INFO - PROCESS | 1641 | |0;dojo.html;2809.185336252487;3272.067460773679;3295.6210035845884;3331.666833316667;3357.916052098699;5301.045811753883;5369.5972802039805;5515.779368825247;5589.804356847511;5595.608307418483;5485.917711234335;5509.752061157247;5562.0266453370705;5581.469760372768;5595.468430499106;4982.476839931809;5030.496950304959;5075.746212689351;5077.289179514871;5127.154019586764;5134.229865520165;5152.149895267276;5170.663906846062;5183.377994640629;5195.870103247411;4952.678075925053;5016.548510634024;5021.046001259749;5065.772040258161;5135.897282054375;5052.0906236877345;5054.570361519275;5065.138926382524;5073.873153171164;5080.1617733074;4969.975150124263;5012.548870601627;5033.395992480889;5042.899142017176;5044.369453818273;4568.291914753218;5488.780448782044;5492.945070549284;5505.724713764296;5512.366077901052;5014.373203349582;5860.589758716891;6035.486983606399;6038.547108966845;6042.456178943872;6094.969525152346;6118.284172697687;6129.786714141116;6137.723802428902;6140.3640251610195;5592.245046918654;5618.57860660448;5624.987502249634;5628.802991895346;5662.5753068520025;6188.907166392508;6198.690065496708;6225.657588832567;6227.532935029891;6244.2819075806865;5747.166660834239;5954.166416701665;5954.732037058343;5995.5803093783015;6038.305594856648;6097.796915383898;6150.862090513269;6160.075988601746;6204.875902481925;6205.2553693557065;6123.112148738408;6132.41742034506;6144.293406258248;6158.983767678373;6163.19878415803;5945.286565612154;6188.81433556994;6196.225471816023;6203.720832562545;6209.316975132731;4817.108834865561;4852.053849499384;4855.271709243571;4861.222204447272;4925.679830811057;4361.563843615677;4376.627986621109;4384.780760961939;4399.186150562092;4415.315626077963;5685.488306052475;5695.829125126253;5699.202111704365;5704.80033198836;5722.599418040697;5925.822225333247;6043.546733994968;6053.031514957585;6126.670355029888;6167.753289868445;5686.60193786431;5726.685032323262;5730.914036289459;5750.741216645178;5775.624584402;5310.628256022042;5371.597130215171;5375.113106337489;5392.757325920343;5398.64908780928;6118.082287656887;6128.938710612837;6211;6212.4408803207925;6215.06773983897;5085.338905942203;6096.603720758137;6107.389261073857;6145.66198859067;6194.442500175006;6180.6600636965395;6182.814515564541;6194.0708893666315;6205.069239614094;6212.0371342441995;5033.899322013613;6090.390960903874;6112.786052488142;6120.08198770188;6122.663253521099;5599.80400685974;5700.002499562643;5890.587658863838;5915.970420147872;5964.373740757158;5522.5858060644805;5528.9723551381985;5543.861403464945;5565.332160140809;5592.608517403743;5723.971380143073;5749.568782341257;5777.3933736957015;5941.673207973603;6020.8795824084145;5786.189933409242;5863.560232982458;5870.412958704266;5872.588918775816;5877.059670452878;5726.885462290814;5763.625364351304;5777.3356064051495;6019.819405417845;6064.272287325549;5648.971755141362;5791.8552036199435;5833.154192642128;5881.3236477803885;5926.881462370642 22:20:08 INFO - PROCESS | 1641 | |1;ext.html;468.18769435030214;483.68560435716756;487.619656667799;509.5108695652174;512.589928057554;28019;28906.421871562557;28983.56524652129;38952;41346.96632584179;33858;42238;42336.36495452563;42468.362974555406;42573.36139957896;9122.042185570519;9337.159655630992;9355.4386736796;9359.157675809176;9368.34421590489;7321.048263725708;7481.6259187040705;9230.261579073658;9391.483468409235;9396.107369799858;9181.816363672722;10667.519961601707;11125.443727813577;11133.83094775045;11508.482118304655;11251.83122253167;11323.660290191307;11345.716357091138;11356.829647555292;11365.602203922865;7337.19290878003;11110.333379997226;11149.21955463118;11150.776984460346;11168.720781980433;27852.72147278542;38462;38685;38728;41312.58687413117;3720.6465385788306;3722.1625134344827;3768.453574231721;3780.28174646819;3782.527184101987;29372.971945982;29373;29585.70414295851;29895.252618684706;29974.85012574945;3039.848007599633;3048.756099512034;3061.8597261856844;3129.8435078246;3171.540126681641;385399;386714;387611;389336;390608;58595.41404585985;58782;59004.81990360255;59118.70440647855;59136;49581.752091239316;50519.98960020779;50589.74705126451;61765.691171543855;61962.76074478575;13490.86509134896;13779.793303100461;13834;14049.086809357359;14194.645133871529;10562.049415552638;10662.360258384522;10670.25308228432;10671.413072280944;10687.305325153995;14224.862011039299;16547.420840270534;16941.407050753412;16957.660846782994;17048.744268835977;6935.757248496278;6953.79138625842;7003.8599228015155;7017.193022802341;7057.859252632529;714.6248219684603;803.863343231652;840.1178762299561;844.3793811548506;851.8935133108362;27368.726312737017;27721.722782772318;28668.71331286702;29358;29469.26326841846;984.8128855517429;1037.1339931157568;1039.111559616517;1042.7653777899911;1140.1619809440056;14789.408423663148;14868.851311486964;15252.084874907541;15306.311215995307;15318.234088295541;491350.5083525809;497333;501217;502057.4897125564;502366;55866.664667036726;55897.16154257689;56096.719516402154;56140.71929640326;56327.155092673645;1308.5812539987112;1357.2806412601337;1358.5720498043283;1361.5234667866366;1361.8161548191065;27777.44445111046;27894.86052569724;27946.882124714783;28535.857320713265;28627;48146.51853481561;48420.5157948416;48548.02903941972;48608.51391486181;48649;368201;427695.3531152563;433095.83452082536;433834.04899849143;435251;30359.392812143193;30633.693663063084;31220.68779312178;37083.814580926926;38331.76851315475;43426.565734343516;44836.551634484546;44871.55128448804;44881;44919.77540112279;31685.940413873024;33374.833125834215;33488.49767253542;34589;36552.26895462129;35277.94166175019;35367;35470;36673.63326366702;36915.81542092272;32757.836210818794;33699.83150084234;35973.64026359703;36060.45909311415;36111.63888361083;27721;28206;29499.705002950555;29683.406331873673;29716.10851674453;22329.665055023863;22852.542949140592;23143.537129257656;23204.26529154033;23220.419489512897 22:20:08 INFO - PROCESS | 1641 | |2;jquery.html;386.72735721316474;390.4377696117589;395.87332053742807;402.80463974972133;421.1176043087398;19348.12933417996;19903.900480497578;20657.967101644914;20714.378568642966;20716.585668286643;11560.942195289033;12144.69638259044;12377.56678516252;16441.013539187657;21183;5198.6880787152795;5334.199870019489;5415.864603384907;5459.590530710193;5918.733656985446;5829.737661805208;5863.648181109126;5866.618669786471;5890.234269544953;6042.939570604303;5608.915866261989;5839.299284085916;5861.677607731573;5868.530517558606;5947.434993675594;5075.314832497603;5801.506871915893;5820;5858.794942177004;5891.734871930774;4989.875253118665;5127.53852153308;5206.843794686128;5208.8437346879655;5245.344331958505;13298.268595227259;13337.799933001013;13408.530701425501;13534.661633459144;13564.45742170312;2485.155047283932;2544.9363765905814;2555.3867071902796;2560.897564097434;2602.5705758549816;8445.408821382505;9866.80266394668;10306.484675766182;10310.32982856112;13351.132176408502;1709.7178965470682;1758.1121533625565;1779.3238569343566;1782.5187199456075;1782.6523827853573;99062;115136.42431787871;123105.76894231033;125167.37416312951;125299;10943.343399396063;11105.389203593719;11283.887161128283;11299.548018079186;11497.885021149681;15147.394104235927;15242.23788810555;15279.312430940634;15297.082175069532;15321.387144514318;7321.963390183015;7627.580483073484;7656.846863062708;7735.22647735222;7787.961060194662;7121.501494895411;7131.607761573059;7274.16347120088;7306.196318404971;7309;4562.292844609091;4622.352870598119;4652.883677908012;4654.418197725285;4721.763911804396;1970.3202395173928;1996.8003199679915;2013.8923592024328;2016.7378240828598;2020.8787472751683;778.9211941461117;1008.2135933971514;1013.9746506337401;1034.5292891734243;1044.1803184500284;20679.966001699853;20825.479363016046;20927;20952;21126.894365528075;999.7100840756099;1002.2232769603615;1032.339302846179;1049.197364016528;1054.583439541377;9989.900100998897;10674.193532385125;10725.011998594766;10794.622188223531;10885.727856803644;619039;626744;629384;643338;644762;114290.42854785673;133130.00304995434;136177.63822361847;137725;139156.38261182414;885.7829831691276;922.806210695748;938.4181807279531;966.2028826218398;967.7967626798311;15652.843471565138;17264.568385790455;17648.470545883643;17658.470245892644;17815.910920445316;49773.253401198286;49941.75145621388;50097.74951125221;50597.24104138515;52714.20928686149;71647;72614.63692681714;73456.26543734495;73538;74149.62925185339;6789.388954994074;8101.392395570474;8201.261886430011;8262.339012879076;8277.461964972257;11320.773584528428;11539.249948753304;12580.930620897327;12917.677058073248;13255.734885302432;10737.355758654505;11038.558457661924;11237.38194399316;11378.54485820591;11415.258008229439;8777.253933415732;10894.455277236266;11046.613368532062;11189;11229.55081796719;11429.371384573928;11558.653240402802;11630.069594432594;11685.240459370114;11766.88233117658;8179.0594081681365;8181;8215.260626543639;8275.379346549153;8306.54956787737;9321.673741419017;10965.013148816644;11029;11417.657470275904;11486.081113511067 22:20:08 INFO - PROCESS | 1641 | |3;mootools.html;1087.5377964365143;1375.539194369886;1424.9287535623223;1429.885609151268;1486.0637798187145;7276.708931642735;7619.276168763966;8176.182381761828;8230;8408.159184081604;8263.297619702318;8361.456505327165;8369.91630083699;8383.622736976835;8400.53797041164;2142.9464263393425;2274.8976296066717;2279.931602051941;2280.5780930527903;2282.052948026567;1918.4628304074881;1988.6420444320017;2109.177420805887;2203.9971812825124;2288.6567014947723;2251.6622506623976;2257.164849005862;2259.7175353080866;2266.580682573721;2267.8299127565415;2207.757146713868;2241.529278851443;2245.887705614729;2245.921392751254;2246;2178.8910554472213;2204.437868343578;2242.2264318809985;2284.371797755614;2295.219625327397;8366.958165209197;8431.072582015973;8448.619812108409;8450.83098338036;8462.87305690415;5020.0963826511215;5187.0693058421875;5197.454267301917;5198.870028249286;5207.791688332462;3231.789933654305;3465.237647717498;3473.2879759649213;3518.085297822559;3553.3603951288756;1156.7900806982298;1183.2427246562122;1226.7485165541043;1249.144336129745;1250.6748245456156;9400.20098291646;10837.891621083845;11018.39398833072;11021.228514004022;11038.613648522343;3836;4188.308929026737;4353.194658988097;4616.192166370939;4638.304254361805;9558.139767420966;9561.760955976157;9574.281928855364;9576.23390128788;9578;5222.7127507987425;5225.059489291964;5232.764525596357;5234.97382513085;5262.158054711304;4114.814833332507;4685.554872287127;4750.8337208197545;4805.687630304019;4844.224924012212;2853.7146285371714;3288.8848890289205;3380.8309584520675;3582.8925132246072;3660.871869484555;1116.3971455413985;1122.4240368354483;1130.8699499557492;1144.4220668562323;1146.850909381775;811.9769090945451;838.7167633520723;844.8014716541608;889.4174315823146;907.7291791491964;5144.382674079135;5182.170852663556;5491.258680078138;5492.434656122986;5708.942910570841;883.4213590098495;883.5008220355479;888.9777755556033;940.3699521320732;1012.4330374989881;3237.2392487765355;3612.837422316002;3673.1000904778502;3733.4773131761576;3834.539855217336;8764.430312029697;9831.508424578742;9869.457179855177;9994.500274986221;10010.749731256778;9779.462129582942;9899.554520046615;9905;9991.550380232908;10016.848062472909;7421.220771818989;7707.499012564053;7716.30553250199;7724.459287849797;7740.380769538536;5288.259643649815;5435.945640543702;5496.6701997880255;5511.0080185566985;5541.722913854372;8651.95674021626;8771.91228087711;8920.955395222982;9004.63981440735;9058.36591438593;8783.91216087831;9082.091790820865;9109.863352049857;9240.445573265357;9242.306826988137;7142.714291428285;7264.273572642694;7278.854422911618;7288.708451661874;7297.562146271241;7799.298063174341;7857.607119644109;7957.721479748181;7960.721374752087;7989.680412783656;7065.505414620927;7078.362947334765;7084.893726594002;7206.063211782434;7303.780886573411;7026;7036.437085033082;7040.3663670269925;7097.503174777922;7102.928970710227;6212.968935155295;6279.120923070683;6357;6370.649614271074;6379.425851673372;4817.9518204817505;4855.854324370274;4894.755262236945;4991.101601711582;5128.435872053997;4915.361003069578;4952.4057113146655;4960.677555958851;5082.136036873814;5156.097682905402 22:20:08 INFO - PROCESS | 1641 | |4;prototype.html;350.3588433167304;354.8385484604505;357.6352120836745;358.8869506105577;361.922186729853;4354.912901741964;4705.411823522059;4991.825286114987;5299.973500132503;5303.390110137326;4420.690551661385;5152.536271735543;5187.610929180308;5204.32343795307;5226.738663066851;3716.089558058273;3839.7120215983773;3891.7859517726515;3921.666658334045;3923.4507168996365;3241.6758324167513;3320.8007519548905;3889.4943657324507;3925.467079628343;3925.5289365276208;3868.4390763339297;3892.5912779158066;3916.980415097935;3921;3934.665553427962;3444.7781181138275;3596.5504311961004;3897.2010737798682;3914.5693973662874;3929.646331830135;3360.327934413103;3366.9663303367142;3387.2717365766234;3390.5253264542985;3394.541736865516;4586.197415452316;4987.925181122286;5037.848864534069;5053.772580233898;5057.620678449131;4464.129494748526;4469.25698977399;4478.507364189936;4484.237679594444;4495.5953964143055;5121.769520371592;5203.791848326063;5333.679979201261;5419.268398766156;5478.945210547883;3698.2973235085246;3733.4213196954242;3738.45792360109;3747.831347589338;3750.549934007909;4844.183431213295;5064.822731204427;5098.107831129574;5190.81832135881;5507.669539827623;3229.7404012435168;3304.454764963802;3678.3746763050344;3698.2973235085788;3704.833282502294;3213.5983002124735;3305.603327600655;3604.8824864292155;3778.981105094457;3806.980965095157;3735.364987952055;3821.923561528754;4176.825612534496;4406.713563618418;4455.287154055401;4723.338732577442;4929.063477939252;5104;5489.945100549024;5546.195801608744;980.0542476510202;1024.4928760263717;1105.729096371378;1215.5806246844825;1248.6378950104368;706.9890057218124;772.7867248420039;829.9170082991652;843.409613270713;848.4569875279826;4083.2850202914847;4265.163666161968;4624.635732458933;4904.4605093439695;4925.088858561177;4490.461144662596;4916.164252077156;4964.003976798712;5106.744662766847;5392.4607539246545;4079.8776036718946;4198.6641068714425;4470.821167153277;4839.701141957542;4974.5771609413605;2285.8057065149646;2757.600147978532;2767.2805070681766;2781.317303031677;2793.6254183943893;5298.986385173609;5395.514403703685;5423.074808442946;5441.564674826004;5442.619016668795;4651.813647585629;4968.29280471368;5215.921761173586;5363.490468405495;5427.185922111715;4870.4155501340065;4915.3855768029;5425.8643533912755;5426.945730542723;5556.111022236423;4699.812007519661;4901.61305631465;5289.677580604849;5297.682388853073;5340.305760251143;4130.648894843852;4422.137683151883;5050.520200580939;5255.298001668233;5579.246801681883;4557.778632167135;5707.603975634491;5745.913811292918;5797.304323481209;5845.866258815417;3702.6852717518236;3774.3960966245268;3794.71539634523;3807.1814559869763;3839.155385815116;5674.531578763251;5684.147377893349;5689.573282003949;5702.7718891243885;5726.914096288476;4665.440147182224;5448.591355648263;5488.423715509974;5502.174673798802;5506.191842160447;5187.365979716377;5357.19642053695;5398.514133727984;5405.486478784509;5422.430644782399;4858.684185527929;5270.367555893317;5274.70331043098;5294.788208471772;5322.414534401135;4528.622473201595;4623.745693986863;4996.451100158963;5371.5971302153275;5390.784368625211;4687.507811679861;5374.758135883816;5376.327959005124;5382.865428364322;5384.6499977501335 22:20:08 INFO - PROCESS | 1641 | |5;yui.html;691.9481038922082;692.2661978302999;694.2848865668363;741.0144507804621;780.6174974262611;14123.081999670027;16487.093209873452;17237.310507579714;17272.395466158687;17671.646567068652;15655.843441565581;15688.921555392235;15689.764653530177;15696.921515392436;15716.921415392935;882.814608932125;908.1009800297691;911.2846415563783;912.4160537256129;912.9360944733871;899.1952202778509;902.6885724425063;903.6837107012559;926.754410081329;928.5403725156024;980.8528720691882;983.0513554419983;985.3693636072919;987.2940847294183;988.3822610868208;968.8546717992288;971.5627967414621;971.946542940138;972.2222222222194;972.3242346569137;720.2293545905883;721.6752461392394;723.1647447198494;723.7322190789441;724.8948902409121;15171.24143792806;15238.619034524114;15265.61835954099;15435.30541125652;15501.069935803887;13862.584122476343;13881;14115.505957291549;14172.787408188886;14233.146011239358;11380.260283081656;11410.486528106256;11538.307701537935;11624.302541847432;11927.045836333073;3719.851205951759;3724.8510059597584;3739.364308067635;3824.1395685970433;3824.2542704172697;90745.54627226888;92965;93790;96804.51597742036;97732;8020.478668886503;8958.68644597436;10115.342502737298;10344.416636872858;11150.553977840795;22582.435439113826;22929.88535057314;22993.655095173584;23007.654885176737;23055.654165187534;7197.208307086216;7539.698412063456;7556.697732090654;7561.470697051263;7680.193579674165;4001.959980400217;4071.1043570414463;4104.856330028435;4255.87232383029;4303.913921721611;3524.7356448266482;3632.3098611263777;3633.073566240592;3634.2913131939017;3638.0541059324764;600.051917969607;675.3651567526509;677.5358879167786;684.852756657321;685.8182581615876;614;624.3039011502142;625.515225700086;633.2780630081711;663.4592806862391;7918.683252669944;8465.322774178174;9203.953980230055;9344.813103738023;9583.424994500352;588.358689028952;626.4143026270451;659.591053546804;667.2360147630935;684.7808701215563;4324.632406245441;4627.213373726475;4679.3916790816975;4801.271542244789;5049.5707864831165;76642.61678691683;78002;78569.60715196388;80812;81885.77171342434;46274.53725462702;59170.40829591649;77636.61181694169;78605.21394786093;81237.18762812414;52990.47009529932;62702.99999999909;64360.35639643637;65045.34954650393;69772;10134.189264858942;10204.2346823987;10225.897741022793;10303.639372621923;10408.427536485566;43846.78076609724;44423.777881110385;45164.45066479977;45646;46787.29819052649;56764;59212.70393648177;59285;59814;60270;12481.438335275116;12664.74670506603;12905.806412903627;12983;13096.410661520064;13854.76528099128;14229.50196743109;14475.131492110508;14698.485553005594;14772.33524491379;12937.353132343156;13102.606921792361;13210.009249306147;13251.734965300833;13777;10020.298579099393;13184.868151318364;13335.3332333381;13660.590182294547;13960;12815.679608009874;12849.678758031125;12964.286964217059;13154.40805163789;13543.86456135426;10632;10853.674389768319;10891.945540272249;11102.888971110186;11207.623963865522;7307.817304567428;8357.749267521984;10987.736410312917;11266.493007814504;11460.94269528647 22:20:08 INFO - PROCESS | 1641 | __end_tp_report 22:20:08 INFO - PROCESS | 1641 | __start_cc_report 22:20:08 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1559 22:20:08 INFO - PROCESS | 1641 | __end_cc_report 22:20:08 INFO - PROCESS | 1641 | __startTimestamp1488867608457__endTimestamp 22:20:08 INFO - PROCESS | 1641 | 22:20:08 INFO - PROCESS | 1641 | ------- Summary: start ------- 22:20:08 INFO - PROCESS | 1641 | Number of tests: 6 22:20:08 INFO - PROCESS | 1641 | 22:20:08 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5579.36 Median:5723.97 stddev:635.21 (11.1%) stddev-sans-first:598.84 22:20:08 INFO - PROCESS | 1641 | Values: 2809.2 3272.1 3295.6 3331.7 3357.9 5301.0 5369.6 5515.8 5589.8 5595.6 5485.9 5509.8 5562.0 5581.5 5595.5 4982.5 5030.5 5075.7 5077.3 5127.2 5134.2 5152.1 5170.7 5183.4 5195.9 4952.7 5016.5 5021.0 5065.8 5135.9 5052.1 5054.6 5065.1 5073.9 5080.2 4970.0 5012.5 5033.4 5042.9 5044.4 4568.3 5488.8 5492.9 5505.7 5512.4 5014.4 5860.6 6035.5 6038.5 6042.5 6095.0 6118.3 6129.8 6137.7 6140.4 5592.2 5618.6 5625.0 5628.8 5662.6 6188.9 6198.7 6225.7 6227.5 6244.3 5747.2 5954.2 5954.7 5995.6 6038.3 6097.8 6150.9 6160.1 6204.9 6205.3 6123.1 6132.4 6144.3 6159.0 6163.2 5945.3 6188.8 6196.2 6203.7 6209.3 4817.1 4852.1 4855.3 4861.2 4925.7 4361.6 4376.6 4384.8 4399.2 4415.3 5685.5 5695.8 5699.2 5704.8 5722.6 5925.8 6043.5 6053.0 6126.7 6167.8 5686.6 5726.7 5730.9 5750.7 5775.6 5310.6 5371.6 5375.1 5392.8 5398.6 6118.1 6128.9 6211.0 6212.4 6215.1 5085.3 6096.6 6107.4 6145.7 6194.4 6180.7 6182.8 6194.1 6205.1 6212.0 5033.9 6090.4 6112.8 6120.1 6122.7 5599.8 5700.0 5890.6 5916.0 5964.4 5522.6 5529.0 5543.9 5565.3 5592.6 5724.0 5749.6 5777.4 5941.7 6020.9 5786.2 5863.6 5870.4 5872.6 5877.1 5726.9 5763.6 5777.3 6019.8 6064.3 5649.0 5791.9 5833.2 5881.3 5926.9 22:20:08 INFO - PROCESS | 1641 | 22:20:08 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:57796.44 Median:36086.05 stddev:116287.31 (322.3%) stddev-sans-first:116533.87 22:20:08 INFO - PROCESS | 1641 | Values: 468.2 483.7 487.6 509.5 512.6 28019.0 28906.4 28983.6 38952.0 41347.0 33858.0 42238.0 42336.4 42468.4 42573.4 9122.0 9337.2 9355.4 9359.2 9368.3 7321.0 7481.6 9230.3 9391.5 9396.1 9181.8 10667.5 11125.4 11133.8 11508.5 11251.8 11323.7 11345.7 11356.8 11365.6 7337.2 11110.3 11149.2 11150.8 11168.7 27852.7 38462.0 38685.0 38728.0 41312.6 3720.6 3722.2 3768.5 3780.3 3782.5 29373.0 29373.0 29585.7 29895.3 29974.9 3039.8 3048.8 3061.9 3129.8 3171.5 385399.0 386714.0 387611.0 389336.0 390608.0 58595.4 58782.0 59004.8 59118.7 59136.0 49581.8 50520.0 50589.7 61765.7 61962.8 13490.9 13779.8 13834.0 14049.1 14194.6 10562.0 10662.4 10670.3 10671.4 10687.3 14224.9 16547.4 16941.4 16957.7 17048.7 6935.8 6953.8 7003.9 7017.2 7057.9 714.6 803.9 840.1 844.4 851.9 27368.7 27721.7 28668.7 29358.0 29469.3 984.8 1037.1 1039.1 1042.8 1140.2 14789.4 14868.9 15252.1 15306.3 15318.2 491350.5 497333.0 501217.0 502057.5 502366.0 55866.7 55897.2 56096.7 56140.7 56327.2 1308.6 1357.3 1358.6 1361.5 1361.8 27777.4 27894.9 27946.9 28535.9 28627.0 48146.5 48420.5 48548.0 48608.5 48649.0 368201.0 427695.4 433095.8 433834.0 435251.0 30359.4 30633.7 31220.7 37083.8 38331.8 43426.6 44836.6 44871.6 44881.0 44919.8 31685.9 33374.8 33488.5 34589.0 36552.3 35277.9 35367.0 35470.0 36673.6 36915.8 32757.8 33699.8 35973.6 36060.5 36111.6 27721.0 28206.0 29499.7 29683.4 29716.1 22329.7 22852.5 23143.5 23204.3 23220.4 22:20:08 INFO - PROCESS | 1641 | 22:20:08 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:35278.49 Median:21154.95 stddev:105454.75 (498.5%) stddev-sans-first:105718.03 22:20:08 INFO - PROCESS | 1641 | Values: 386.7 390.4 395.9 402.8 421.1 19348.1 19903.9 20658.0 20714.4 20716.6 11560.9 12144.7 12377.6 16441.0 21183.0 5198.7 5334.2 5415.9 5459.6 5918.7 5829.7 5863.6 5866.6 5890.2 6042.9 5608.9 5839.3 5861.7 5868.5 5947.4 5075.3 5801.5 5820.0 5858.8 5891.7 4989.9 5127.5 5206.8 5208.8 5245.3 13298.3 13337.8 13408.5 13534.7 13564.5 2485.2 2544.9 2555.4 2560.9 2602.6 8445.4 9866.8 10306.5 10310.3 13351.1 1709.7 1758.1 1779.3 1782.5 1782.7 99062.0 115136.4 123105.8 125167.4 125299.0 10943.3 11105.4 11283.9 11299.5 11497.9 15147.4 15242.2 15279.3 15297.1 15321.4 7322.0 7627.6 7656.8 7735.2 7788.0 7121.5 7131.6 7274.2 7306.2 7309.0 4562.3 4622.4 4652.9 4654.4 4721.8 1970.3 1996.8 2013.9 2016.7 2020.9 778.9 1008.2 1014.0 1034.5 1044.2 20680.0 20825.5 20927.0 20952.0 21126.9 999.7 1002.2 1032.3 1049.2 1054.6 9989.9 10674.2 10725.0 10794.6 10885.7 619039.0 626744.0 629384.0 643338.0 644762.0 114290.4 133130.0 136177.6 137725.0 139156.4 885.8 922.8 938.4 966.2 967.8 15652.8 17264.6 17648.5 17658.5 17815.9 49773.3 49941.8 50097.7 50597.2 52714.2 71647.0 72614.6 73456.3 73538.0 74149.6 6789.4 8101.4 8201.3 8262.3 8277.5 11320.8 11539.2 12580.9 12917.7 13255.7 10737.4 11038.6 11237.4 11378.5 11415.3 8777.3 10894.5 11046.6 11189.0 11229.6 11429.4 11558.7 11630.1 11685.2 11766.9 8179.1 8181.0 8215.3 8275.4 8306.5 9321.7 10965.0 11029.0 11417.7 11486.1 22:20:08 INFO - PROCESS | 1641 | 22:20:08 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5363.33 Median:5228.91 stddev:2959.73 (56.6%) stddev-sans-first:2950.58 22:20:08 INFO - PROCESS | 1641 | Values: 1087.5 1375.5 1424.9 1429.9 1486.1 7276.7 7619.3 8176.2 8230.0 8408.2 8263.3 8361.5 8369.9 8383.6 8400.5 2142.9 2274.9 2279.9 2280.6 2282.1 1918.5 1988.6 2109.2 2204.0 2288.7 2251.7 2257.2 2259.7 2266.6 2267.8 2207.8 2241.5 2245.9 2245.9 2246.0 2178.9 2204.4 2242.2 2284.4 2295.2 8367.0 8431.1 8448.6 8450.8 8462.9 5020.1 5187.1 5197.5 5198.9 5207.8 3231.8 3465.2 3473.3 3518.1 3553.4 1156.8 1183.2 1226.7 1249.1 1250.7 9400.2 10837.9 11018.4 11021.2 11038.6 3836.0 4188.3 4353.2 4616.2 4638.3 9558.1 9561.8 9574.3 9576.2 9578.0 5222.7 5225.1 5232.8 5235.0 5262.2 4114.8 4685.6 4750.8 4805.7 4844.2 2853.7 3288.9 3380.8 3582.9 3660.9 1116.4 1122.4 1130.9 1144.4 1146.9 812.0 838.7 844.8 889.4 907.7 5144.4 5182.2 5491.3 5492.4 5708.9 883.4 883.5 889.0 940.4 1012.4 3237.2 3612.8 3673.1 3733.5 3834.5 8764.4 9831.5 9869.5 9994.5 10010.7 9779.5 9899.6 9905.0 9991.6 10016.8 7421.2 7707.5 7716.3 7724.5 7740.4 5288.3 5435.9 5496.7 5511.0 5541.7 8652.0 8771.9 8921.0 9004.6 9058.4 8783.9 9082.1 9109.9 9240.4 9242.3 7142.7 7264.3 7278.9 7288.7 7297.6 7799.3 7857.6 7957.7 7960.7 7989.7 7065.5 7078.4 7084.9 7206.1 7303.8 7026.0 7036.4 7040.4 7097.5 7102.9 6213.0 6279.1 6357.0 6370.6 6379.4 4818.0 4855.9 4894.8 4991.1 5128.4 4915.4 4952.4 4960.7 5082.1 5156.1 22:20:08 INFO - PROCESS | 1641 | 22:20:08 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4287.57 Median:4841.94 stddev:1321.26 (27.3%) stddev-sans-first:1291.49 22:20:08 INFO - PROCESS | 1641 | Values: 350.4 354.8 357.6 358.9 361.9 4354.9 4705.4 4991.8 5300.0 5303.4 4420.7 5152.5 5187.6 5204.3 5226.7 3716.1 3839.7 3891.8 3921.7 3923.5 3241.7 3320.8 3889.5 3925.5 3925.5 3868.4 3892.6 3917.0 3921.0 3934.7 3444.8 3596.6 3897.2 3914.6 3929.6 3360.3 3367.0 3387.3 3390.5 3394.5 4586.2 4987.9 5037.8 5053.8 5057.6 4464.1 4469.3 4478.5 4484.2 4495.6 5121.8 5203.8 5333.7 5419.3 5478.9 3698.3 3733.4 3738.5 3747.8 3750.5 4844.2 5064.8 5098.1 5190.8 5507.7 3229.7 3304.5 3678.4 3698.3 3704.8 3213.6 3305.6 3604.9 3779.0 3807.0 3735.4 3821.9 4176.8 4406.7 4455.3 4723.3 4929.1 5104.0 5489.9 5546.2 980.1 1024.5 1105.7 1215.6 1248.6 707.0 772.8 829.9 843.4 848.5 4083.3 4265.2 4624.6 4904.5 4925.1 4490.5 4916.2 4964.0 5106.7 5392.5 4079.9 4198.7 4470.8 4839.7 4974.6 2285.8 2757.6 2767.3 2781.3 2793.6 5299.0 5395.5 5423.1 5441.6 5442.6 4651.8 4968.3 5215.9 5363.5 5427.2 4870.4 4915.4 5425.9 5426.9 5556.1 4699.8 4901.6 5289.7 5297.7 5340.3 4130.6 4422.1 5050.5 5255.3 5579.2 4557.8 5707.6 5745.9 5797.3 5845.9 3702.7 3774.4 3794.7 3807.2 3839.2 5674.5 5684.1 5689.6 5702.8 5726.9 4665.4 5448.6 5488.4 5502.2 5506.2 5187.4 5357.2 5398.5 5405.5 5422.4 4858.7 5270.4 5274.7 5294.8 5322.4 4528.6 4623.7 4996.5 5371.6 5390.8 4687.5 5374.8 5376.3 5382.9 5384.6 22:20:08 INFO - PROCESS | 1641 | 22:20:08 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:18124.16 Median:25136.61 stddev:24169.89 (96.2%) stddev-sans-first:24202.25 22:20:08 INFO - PROCESS | 1641 | Values: 691.9 692.3 694.3 741.0 780.6 14123.1 16487.1 17237.3 17272.4 17671.6 15655.8 15688.9 15689.8 15696.9 15716.9 882.8 908.1 911.3 912.4 912.9 899.2 902.7 903.7 926.8 928.5 980.9 983.1 985.4 987.3 988.4 968.9 971.6 971.9 972.2 972.3 720.2 721.7 723.2 723.7 724.9 15171.2 15238.6 15265.6 15435.3 15501.1 13862.6 13881.0 14115.5 14172.8 14233.1 11380.3 11410.5 11538.3 11624.3 11927.0 3719.9 3724.9 3739.4 3824.1 3824.3 90745.5 92965.0 93790.0 96804.5 97732.0 8020.5 8958.7 10115.3 10344.4 11150.6 22582.4 22929.9 22993.7 23007.7 23055.7 7197.2 7539.7 7556.7 7561.5 7680.2 4002.0 4071.1 4104.9 4255.9 4303.9 3524.7 3632.3 3633.1 3634.3 3638.1 600.1 675.4 677.5 684.9 685.8 614.0 624.3 625.5 633.3 663.5 7918.7 8465.3 9204.0 9344.8 9583.4 588.4 626.4 659.6 667.2 684.8 4324.6 4627.2 4679.4 4801.3 5049.6 76642.6 78002.0 78569.6 80812.0 81885.8 46274.5 59170.4 77636.6 78605.2 81237.2 52990.5 62703.0 64360.4 65045.3 69772.0 10134.2 10204.2 10225.9 10303.6 10408.4 43846.8 44423.8 45164.5 45646.0 46787.3 56764.0 59212.7 59285.0 59814.0 60270.0 12481.4 12664.7 12905.8 12983.0 13096.4 13854.8 14229.5 14475.1 14698.5 14772.3 12937.4 13102.6 13210.0 13251.7 13777.0 10020.3 13184.9 13335.3 13660.6 13960.0 12815.7 12849.7 12964.3 13154.4 13543.9 10632.0 10853.7 10891.9 11102.9 11207.6 7307.8 8357.7 10987.7 11266.5 11460.9 22:20:08 INFO - PROCESS | 1641 | -------- Summary: end -------- 22:20:08 INFO - PROCESS | 1641 | 22:20:09 INFO - TEST-INFO | 1641: exit 0 22:20:09 INFO - TEST-OK | dromaeo_css | took 1119855ms 22:20:09 INFO - TEST-START | kraken 22:20:09 INFO - operating with platform_type : mac_ 22:20:09 INFO - Initialising browser for kraken test... 22:20:09 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpZQjPH0/profile http://localhost:49241/getInfo.html) 22:20:11 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 22:20:11 INFO - PROCESS | 1648 | colorDepth:24 22:20:11 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 22:20:11 INFO - PROCESS | 1648 | __metrics 22:20:11 INFO - PROCESS | 1648 | 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" 22:20:11 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:20:12 INFO - TEST-INFO | 1648: exit 0 22:20:12 INFO - Browser initialized. 22:20:12 INFO - Running cycle 1/1 for kraken test... 22:20:12 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpZQjPH0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:24 INFO - PROCESS | 1649 | RSS: Main: 237387776 22:20:24 INFO - PROCESS | 1649 | 22:20:27 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 22:20:28 INFO - PROCESS | 1649 | RSS: Main: 288813056 22:20:28 INFO - PROCESS | 1649 | 22:20:31 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 22:20:31 INFO - PROCESS | 1649 | RSS: Main: 291176448 22:20:31 INFO - PROCESS | 1649 | 22:20:34 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 22:20:35 INFO - PROCESS | 1649 | RSS: Main: 382533632 22:20:35 INFO - PROCESS | 1649 | 22:20:37 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 22:20:38 INFO - PROCESS | 1649 | RSS: Main: 287158272 22:20:38 INFO - PROCESS | 1649 | 22:20:40 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:20:41 INFO - PROCESS | 1649 | RSS: Main: 288411648 22:20:41 INFO - PROCESS | 1649 | 22:20:43 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 22:20:44 INFO - PROCESS | 1649 | RSS: Main: 329695232 22:20:44 INFO - PROCESS | 1649 | 22:20:47 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 22:20:48 INFO - PROCESS | 1649 | RSS: Main: 333172736 22:20:48 INFO - PROCESS | 1649 | 22:20:51 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 22:20:51 INFO - PROCESS | 1649 | RSS: Main: 331104256 22:20:51 INFO - PROCESS | 1649 | 22:20:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:20:53 INFO - PROCESS | 1649 | RSS: Main: 306507776 22:20:53 INFO - PROCESS | 1649 | 22:20:55 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:20:56 INFO - PROCESS | 1649 | RSS: Main: 312893440 22:20:56 INFO - PROCESS | 1649 | 22:20:58 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:20:59 INFO - PROCESS | 1649 | RSS: Main: 314171392 22:20:59 INFO - PROCESS | 1649 | 22:21:02 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:21:03 INFO - PROCESS | 1649 | RSS: Main: 331157504 22:21:03 INFO - PROCESS | 1649 | 22:21:06 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:21:07 INFO - PROCESS | 1649 | RSS: Main: 324624384 22:21:07 INFO - PROCESS | 1649 | 22:21:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 22:21:09 INFO - PROCESS | 1649 | RSS: Main: 369496064 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | __start_tp_report 22:21:09 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 22:21:09 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 22:21:09 INFO - PROCESS | 1649 | |i|pagename|runs| 22:21:09 INFO - PROCESS | 1649 | |0;ai-astar;113;115;113;114;113;114;113;114;113;114 22:21:09 INFO - PROCESS | 1649 | |1;audio-beat-detection;145;111;113;154;114;111;112;115;158;146 22:21:09 INFO - PROCESS | 1649 | |2;audio-dft;186;183;182;185;181;182;183;182;184;184 22:21:09 INFO - PROCESS | 1649 | |3;audio-fft;82;61;60;106;84;84;80;61;79;61 22:21:09 INFO - PROCESS | 1649 | |4;audio-oscillator;88;58;89;91;101;81;86;68;68;85 22:21:09 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;88;89;89;88;89;88;88;88;88;88 22:21:09 INFO - PROCESS | 1649 | |6;imaging-darkroom;100;143;95;96;94;95;96;95;95;96 22:21:09 INFO - PROCESS | 1649 | |7;imaging-desaturate;86;88;88;88;88;88;87;88;87;86 22:21:09 INFO - PROCESS | 1649 | |8;json-parse-financial;61;60;59;59;59;59;59;59;59;59 22:21:09 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;73;64;93;117;87;74;70;69;69;72 22:21:09 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;94;94;93;93;109;117;116;93;93;94 22:21:09 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;158;151;147;152;148;145;144;142;185;165 22:21:09 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;181;162;218;250;196;185;183;185;183;180 22:21:09 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;70;69;68;68;69;69;71;72;82;87 22:21:09 INFO - PROCESS | 1649 | __end_tp_report 22:21:09 INFO - PROCESS | 1649 | __start_cc_report 22:21:09 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2103 22:21:09 INFO - PROCESS | 1649 | __end_cc_report 22:21:09 INFO - PROCESS | 1649 | __startTimestamp1488867669243__endTimestamp 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | ------- Summary: start ------- 22:21:09 INFO - PROCESS | 1649 | Number of tests: 14 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 22:21:09 INFO - PROCESS | 1649 | Values: 113.0 115.0 113.0 114.0 113.0 114.0 113.0 114.0 113.0 114.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:130.00 stddev:20.04 (15.4%) stddev-sans-first:20.27 22:21:09 INFO - PROCESS | 1649 | Values: 145.0 111.0 113.0 154.0 114.0 111.0 112.0 115.0 158.0 146.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:1.55 (0.8%) stddev-sans-first:1.27 22:21:09 INFO - PROCESS | 1649 | Values: 186.0 183.0 182.0 185.0 181.0 182.0 183.0 182.0 184.0 184.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:75.80 Median:79.50 stddev:14.98 (18.8%) stddev-sans-first:15.72 22:21:09 INFO - PROCESS | 1649 | Values: 82.0 61.0 60.0 106.0 84.0 84.0 80.0 61.0 79.0 61.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:81.50 Median:85.50 stddev:12.99 (15.2%) stddev-sans-first:13.56 22:21:09 INFO - PROCESS | 1649 | Values: 88.0 58.0 89.0 91.0 101.0 81.0 86.0 68.0 68.0 85.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:88.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:21:09 INFO - PROCESS | 1649 | Values: 88.0 89.0 89.0 88.0 89.0 88.0 88.0 88.0 88.0 88.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:95.00 stddev:15.02 (15.8%) stddev-sans-first:15.93 22:21:09 INFO - PROCESS | 1649 | Values: 100.0 143.0 95.0 96.0 94.0 95.0 96.0 95.0 95.0 96.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:87.40 Median:88.00 stddev:0.84 (1.0%) stddev-sans-first:0.73 22:21:09 INFO - PROCESS | 1649 | Values: 86.0 88.0 88.0 88.0 88.0 88.0 87.0 88.0 87.0 86.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.33 22:21:09 INFO - PROCESS | 1649 | Values: 61.0 60.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:78.80 Median:72.50 stddev:16.05 (22.1%) stddev-sans-first:16.89 22:21:09 INFO - PROCESS | 1649 | Values: 73.0 64.0 93.0 117.0 87.0 74.0 70.0 69.0 69.0 72.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:99.60 Median:93.00 stddev:10.16 (10.9%) stddev-sans-first:10.57 22:21:09 INFO - PROCESS | 1649 | Values: 94.0 94.0 93.0 93.0 109.0 117.0 116.0 93.0 93.0 94.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:151.50 stddev:13.00 (8.6%) stddev-sans-first:13.69 22:21:09 INFO - PROCESS | 1649 | Values: 158.0 151.0 147.0 152.0 148.0 145.0 144.0 142.0 185.0 165.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.30 Median:185.00 stddev:24.68 (13.3%) stddev-sans-first:25.83 22:21:09 INFO - PROCESS | 1649 | Values: 181.0 162.0 218.0 250.0 196.0 185.0 183.0 185.0 183.0 180.0 22:21:09 INFO - PROCESS | 1649 | 22:21:09 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:70.50 stddev:6.55 (9.3%) stddev-sans-first:6.89 22:21:09 INFO - PROCESS | 1649 | Values: 70.0 69.0 68.0 68.0 69.0 69.0 71.0 72.0 82.0 87.0 22:21:09 INFO - PROCESS | 1649 | -------- Summary: end -------- 22:21:09 INFO - PROCESS | 1649 | 22:21:10 INFO - TEST-INFO | 1649: exit 0 22:21:10 INFO - TEST-OK | kraken | took 61105ms 22:21:10 INFO - SUITE-END | took 1180s 22:21:10 INFO - Completed test suite (00:19:41) 22:21:10 INFO - javascript benchmark 22:21:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6993.6575028019315, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2809.185336252487, 3272.067460773679, 3295.6210035845884, 3331.666833316667, 3357.916052098699, 5301.045811753883, 5369.5972802039805, 5515.779368825247, 5589.804356847511, 5595.608307418483, 5485.917711234335, 5509.752061157247, 5562.0266453370705, 5581.469760372768, 5595.468430499106, 4982.476839931809, 5030.496950304959, 5075.746212689351, 5077.289179514871, 5127.154019586764, 5134.229865520165, 5152.149895267276, 5170.663906846062, 5183.377994640629, 5195.870103247411, 4952.678075925053, 5016.548510634024, 5021.046001259749, 5065.772040258161, 5135.897282054375, 5052.0906236877345, 5054.570361519275, 5065.138926382524, 5073.873153171164, 5080.1617733074, 4969.975150124263, 5012.548870601627, 5033.395992480889, 5042.899142017176, 5044.369453818273, 4568.291914753218, 5488.780448782044, 5492.945070549284, 5505.724713764296, 5512.366077901052, 5014.373203349582, 5860.589758716891, 6035.486983606399, 6038.547108966845, 6042.456178943872, 6094.969525152346, 6118.284172697687, 6129.786714141116, 6137.723802428902, 6140.3640251610195, 5592.245046918654, 5618.57860660448, 5624.987502249634, 5628.802991895346, 5662.5753068520025, 6188.907166392508, 6198.690065496708, 6225.657588832567, 6227.532935029891, 6244.2819075806865, 5747.166660834239, 5954.166416701665, 5954.732037058343, 5995.5803093783015, 6038.305594856648, 6097.796915383898, 6150.862090513269, 6160.075988601746, 6204.875902481925, 6205.2553693557065, 6123.112148738408, 6132.41742034506, 6144.293406258248, 6158.983767678373, 6163.19878415803, 5945.286565612154, 6188.81433556994, 6196.225471816023, 6203.720832562545, 6209.316975132731, 4817.108834865561, 4852.053849499384, 4855.271709243571, 4861.222204447272, 4925.679830811057, 4361.563843615677, 4376.627986621109, 4384.780760961939, 4399.186150562092, 4415.315626077963, 5685.488306052475, 5695.829125126253, 5699.202111704365, 5704.80033198836, 5722.599418040697, 5925.822225333247, 6043.546733994968, 6053.031514957585, 6126.670355029888, 6167.753289868445, 5686.60193786431, 5726.685032323262, 5730.914036289459, 5750.741216645178, 5775.624584402, 5310.628256022042, 5371.597130215171, 5375.113106337489, 5392.757325920343, 5398.64908780928, 6118.082287656887, 6128.938710612837, 6211.0, 6212.4408803207925, 6215.06773983897, 5085.338905942203, 6096.603720758137, 6107.389261073857, 6145.66198859067, 6194.442500175006, 6180.6600636965395, 6182.814515564541, 6194.0708893666315, 6205.069239614094, 6212.0371342441995, 5033.899322013613, 6090.390960903874, 6112.786052488142, 6120.08198770188, 6122.663253521099, 5599.80400685974, 5700.002499562643, 5890.587658863838, 5915.970420147872, 5964.373740757158, 5522.5858060644805, 5528.9723551381985, 5543.861403464945, 5565.332160140809, 5592.608517403743, 5723.971380143073, 5749.568782341257, 5777.3933736957015, 5941.673207973603, 6020.8795824084145, 5786.189933409242, 5863.560232982458, 5870.412958704266, 5872.588918775816, 5877.059670452878, 5726.885462290814, 5763.625364351304, 5777.3356064051495, 6019.819405417845, 6064.272287325549, 5648.971755141362, 5791.8552036199435, 5833.154192642128, 5881.3236477803885, 5926.881462370642], "value": 5538.931521477892, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.18769435030214, 483.68560435716756, 487.619656667799, 509.5108695652174, 512.589928057554, 28019.0, 28906.421871562557, 28983.56524652129, 38952.0, 41346.96632584179, 33858.0, 42238.0, 42336.36495452563, 42468.362974555406, 42573.36139957896, 9122.042185570519, 9337.159655630992, 9355.4386736796, 9359.157675809176, 9368.34421590489, 7321.048263725708, 7481.6259187040705, 9230.261579073658, 9391.483468409235, 9396.107369799858, 9181.816363672722, 10667.519961601707, 11125.443727813577, 11133.83094775045, 11508.482118304655, 11251.83122253167, 11323.660290191307, 11345.716357091138, 11356.829647555292, 11365.602203922865, 7337.19290878003, 11110.333379997226, 11149.21955463118, 11150.776984460346, 11168.720781980433, 27852.72147278542, 38462.0, 38685.0, 38728.0, 41312.58687413117, 3720.6465385788306, 3722.1625134344827, 3768.453574231721, 3780.28174646819, 3782.527184101987, 29372.971945982, 29373.0, 29585.70414295851, 29895.252618684706, 29974.85012574945, 3039.848007599633, 3048.756099512034, 3061.8597261856844, 3129.8435078246, 3171.540126681641, 385399.0, 386714.0, 387611.0, 389336.0, 390608.0, 58595.41404585985, 58782.0, 59004.81990360255, 59118.70440647855, 59136.0, 49581.752091239316, 50519.98960020779, 50589.74705126451, 61765.691171543855, 61962.76074478575, 13490.86509134896, 13779.793303100461, 13834.0, 14049.086809357359, 14194.645133871529, 10562.049415552638, 10662.360258384522, 10670.25308228432, 10671.413072280944, 10687.305325153995, 14224.862011039299, 16547.420840270534, 16941.407050753412, 16957.660846782994, 17048.744268835977, 6935.757248496278, 6953.79138625842, 7003.8599228015155, 7017.193022802341, 7057.859252632529, 714.6248219684603, 803.863343231652, 840.1178762299561, 844.3793811548506, 851.8935133108362, 27368.726312737017, 27721.722782772318, 28668.71331286702, 29358.0, 29469.26326841846, 984.8128855517429, 1037.1339931157568, 1039.111559616517, 1042.7653777899911, 1140.1619809440056, 14789.408423663148, 14868.851311486964, 15252.084874907541, 15306.311215995307, 15318.234088295541, 491350.5083525809, 497333.0, 501217.0, 502057.4897125564, 502366.0, 55866.664667036726, 55897.16154257689, 56096.719516402154, 56140.71929640326, 56327.155092673645, 1308.5812539987112, 1357.2806412601337, 1358.5720498043283, 1361.5234667866366, 1361.8161548191065, 27777.44445111046, 27894.86052569724, 27946.882124714783, 28535.857320713265, 28627.0, 48146.51853481561, 48420.5157948416, 48548.02903941972, 48608.51391486181, 48649.0, 368201.0, 427695.3531152563, 433095.83452082536, 433834.04899849143, 435251.0, 30359.392812143193, 30633.693663063084, 31220.68779312178, 37083.814580926926, 38331.76851315475, 43426.565734343516, 44836.551634484546, 44871.55128448804, 44881.0, 44919.77540112279, 31685.940413873024, 33374.833125834215, 33488.49767253542, 34589.0, 36552.26895462129, 35277.94166175019, 35367.0, 35470.0, 36673.63326366702, 36915.81542092272, 32757.836210818794, 33699.83150084234, 35973.64026359703, 36060.45909311415, 36111.63888361083, 27721.0, 28206.0, 29499.705002950555, 29683.406331873673, 29716.10851674453, 22329.665055023863, 22852.542949140592, 23143.537129257656, 23204.26529154033, 23220.419489512897], "value": 18697.58422410858, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.72735721316474, 390.4377696117589, 395.87332053742807, 402.80463974972133, 421.1176043087398, 19348.12933417996, 19903.900480497578, 20657.967101644914, 20714.378568642966, 20716.585668286643, 11560.942195289033, 12144.69638259044, 12377.56678516252, 16441.013539187657, 21183.0, 5198.6880787152795, 5334.199870019489, 5415.864603384907, 5459.590530710193, 5918.733656985446, 5829.737661805208, 5863.648181109126, 5866.618669786471, 5890.234269544953, 6042.939570604303, 5608.915866261989, 5839.299284085916, 5861.677607731573, 5868.530517558606, 5947.434993675594, 5075.314832497603, 5801.506871915893, 5820.0, 5858.794942177004, 5891.734871930774, 4989.875253118665, 5127.53852153308, 5206.843794686128, 5208.8437346879655, 5245.344331958505, 13298.268595227259, 13337.799933001013, 13408.530701425501, 13534.661633459144, 13564.45742170312, 2485.155047283932, 2544.9363765905814, 2555.3867071902796, 2560.897564097434, 2602.5705758549816, 8445.408821382505, 9866.80266394668, 10306.484675766182, 10310.32982856112, 13351.132176408502, 1709.7178965470682, 1758.1121533625565, 1779.3238569343566, 1782.5187199456075, 1782.6523827853573, 99062.0, 115136.42431787871, 123105.76894231033, 125167.37416312951, 125299.0, 10943.343399396063, 11105.389203593719, 11283.887161128283, 11299.548018079186, 11497.885021149681, 15147.394104235927, 15242.23788810555, 15279.312430940634, 15297.082175069532, 15321.387144514318, 7321.963390183015, 7627.580483073484, 7656.846863062708, 7735.22647735222, 7787.961060194662, 7121.501494895411, 7131.607761573059, 7274.16347120088, 7306.196318404971, 7309.0, 4562.292844609091, 4622.352870598119, 4652.883677908012, 4654.418197725285, 4721.763911804396, 1970.3202395173928, 1996.8003199679915, 2013.8923592024328, 2016.7378240828598, 2020.8787472751683, 778.9211941461117, 1008.2135933971514, 1013.9746506337401, 1034.5292891734243, 1044.1803184500284, 20679.966001699853, 20825.479363016046, 20927.0, 20952.0, 21126.894365528075, 999.7100840756099, 1002.2232769603615, 1032.339302846179, 1049.197364016528, 1054.583439541377, 9989.900100998897, 10674.193532385125, 10725.011998594766, 10794.622188223531, 10885.727856803644, 619039.0, 626744.0, 629384.0, 643338.0, 644762.0, 114290.42854785673, 133130.00304995434, 136177.63822361847, 137725.0, 139156.38261182414, 885.7829831691276, 922.806210695748, 938.4181807279531, 966.2028826218398, 967.7967626798311, 15652.843471565138, 17264.568385790455, 17648.470545883643, 17658.470245892644, 17815.910920445316, 49773.253401198286, 49941.75145621388, 50097.74951125221, 50597.24104138515, 52714.20928686149, 71647.0, 72614.63692681714, 73456.26543734495, 73538.0, 74149.62925185339, 6789.388954994074, 8101.392395570474, 8201.261886430011, 8262.339012879076, 8277.461964972257, 11320.773584528428, 11539.249948753304, 12580.930620897327, 12917.677058073248, 13255.734885302432, 10737.355758654505, 11038.558457661924, 11237.38194399316, 11378.54485820591, 11415.258008229439, 8777.253933415732, 10894.455277236266, 11046.613368532062, 11189.0, 11229.55081796719, 11429.371384573928, 11558.653240402802, 11630.069594432594, 11685.240459370114, 11766.88233117658, 8179.0594081681365, 8181.0, 8215.260626543639, 8275.379346549153, 8306.54956787737, 9321.673741419017, 10965.013148816644, 11029.0, 11417.657470275904, 11486.081113511067], "value": 9236.644101192498, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1087.5377964365143, 1375.539194369886, 1424.9287535623223, 1429.885609151268, 1486.0637798187145, 7276.708931642735, 7619.276168763966, 8176.182381761828, 8230.0, 8408.159184081604, 8263.297619702318, 8361.456505327165, 8369.91630083699, 8383.622736976835, 8400.53797041164, 2142.9464263393425, 2274.8976296066717, 2279.931602051941, 2280.5780930527903, 2282.052948026567, 1918.4628304074881, 1988.6420444320017, 2109.177420805887, 2203.9971812825124, 2288.6567014947723, 2251.6622506623976, 2257.164849005862, 2259.7175353080866, 2266.580682573721, 2267.8299127565415, 2207.757146713868, 2241.529278851443, 2245.887705614729, 2245.921392751254, 2246.0, 2178.8910554472213, 2204.437868343578, 2242.2264318809985, 2284.371797755614, 2295.219625327397, 8366.958165209197, 8431.072582015973, 8448.619812108409, 8450.83098338036, 8462.87305690415, 5020.0963826511215, 5187.0693058421875, 5197.454267301917, 5198.870028249286, 5207.791688332462, 3231.789933654305, 3465.237647717498, 3473.2879759649213, 3518.085297822559, 3553.3603951288756, 1156.7900806982298, 1183.2427246562122, 1226.7485165541043, 1249.144336129745, 1250.6748245456156, 9400.20098291646, 10837.891621083845, 11018.39398833072, 11021.228514004022, 11038.613648522343, 3836.0, 4188.308929026737, 4353.194658988097, 4616.192166370939, 4638.304254361805, 9558.139767420966, 9561.760955976157, 9574.281928855364, 9576.23390128788, 9578.0, 5222.7127507987425, 5225.059489291964, 5232.764525596357, 5234.97382513085, 5262.158054711304, 4114.814833332507, 4685.554872287127, 4750.8337208197545, 4805.687630304019, 4844.224924012212, 2853.7146285371714, 3288.8848890289205, 3380.8309584520675, 3582.8925132246072, 3660.871869484555, 1116.3971455413985, 1122.4240368354483, 1130.8699499557492, 1144.4220668562323, 1146.850909381775, 811.9769090945451, 838.7167633520723, 844.8014716541608, 889.4174315823146, 907.7291791491964, 5144.382674079135, 5182.170852663556, 5491.258680078138, 5492.434656122986, 5708.942910570841, 883.4213590098495, 883.5008220355479, 888.9777755556033, 940.3699521320732, 1012.4330374989881, 3237.2392487765355, 3612.837422316002, 3673.1000904778502, 3733.4773131761576, 3834.539855217336, 8764.430312029697, 9831.508424578742, 9869.457179855177, 9994.500274986221, 10010.749731256778, 9779.462129582942, 9899.554520046615, 9905.0, 9991.550380232908, 10016.848062472909, 7421.220771818989, 7707.499012564053, 7716.30553250199, 7724.459287849797, 7740.380769538536, 5288.259643649815, 5435.945640543702, 5496.6701997880255, 5511.0080185566985, 5541.722913854372, 8651.95674021626, 8771.91228087711, 8920.955395222982, 9004.63981440735, 9058.36591438593, 8783.91216087831, 9082.091790820865, 9109.863352049857, 9240.445573265357, 9242.306826988137, 7142.714291428285, 7264.273572642694, 7278.854422911618, 7288.708451661874, 7297.562146271241, 7799.298063174341, 7857.607119644109, 7957.721479748181, 7960.721374752087, 7989.680412783656, 7065.505414620927, 7078.362947334765, 7084.893726594002, 7206.063211782434, 7303.780886573411, 7026.0, 7036.437085033082, 7040.3663670269925, 7097.503174777922, 7102.928970710227, 6212.968935155295, 6279.120923070683, 6357.0, 6370.649614271074, 6379.425851673372, 4817.9518204817505, 4855.854324370274, 4894.755262236945, 4991.101601711582, 5128.435872053997, 4915.361003069578, 4952.4057113146655, 4960.677555958851, 5082.136036873814, 5156.097682905402], "value": 4330.072984212007, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.3588433167304, 354.8385484604505, 357.6352120836745, 358.8869506105577, 361.922186729853, 4354.912901741964, 4705.411823522059, 4991.825286114987, 5299.973500132503, 5303.390110137326, 4420.690551661385, 5152.536271735543, 5187.610929180308, 5204.32343795307, 5226.738663066851, 3716.089558058273, 3839.7120215983773, 3891.7859517726515, 3921.666658334045, 3923.4507168996365, 3241.6758324167513, 3320.8007519548905, 3889.4943657324507, 3925.467079628343, 3925.5289365276208, 3868.4390763339297, 3892.5912779158066, 3916.980415097935, 3921.0, 3934.665553427962, 3444.7781181138275, 3596.5504311961004, 3897.2010737798682, 3914.5693973662874, 3929.646331830135, 3360.327934413103, 3366.9663303367142, 3387.2717365766234, 3390.5253264542985, 3394.541736865516, 4586.197415452316, 4987.925181122286, 5037.848864534069, 5053.772580233898, 5057.620678449131, 4464.129494748526, 4469.25698977399, 4478.507364189936, 4484.237679594444, 4495.5953964143055, 5121.769520371592, 5203.791848326063, 5333.679979201261, 5419.268398766156, 5478.945210547883, 3698.2973235085246, 3733.4213196954242, 3738.45792360109, 3747.831347589338, 3750.549934007909, 4844.183431213295, 5064.822731204427, 5098.107831129574, 5190.81832135881, 5507.669539827623, 3229.7404012435168, 3304.454764963802, 3678.3746763050344, 3698.2973235085788, 3704.833282502294, 3213.5983002124735, 3305.603327600655, 3604.8824864292155, 3778.981105094457, 3806.980965095157, 3735.364987952055, 3821.923561528754, 4176.825612534496, 4406.713563618418, 4455.287154055401, 4723.338732577442, 4929.063477939252, 5104.0, 5489.945100549024, 5546.195801608744, 980.0542476510202, 1024.4928760263717, 1105.729096371378, 1215.5806246844825, 1248.6378950104368, 706.9890057218124, 772.7867248420039, 829.9170082991652, 843.409613270713, 848.4569875279826, 4083.2850202914847, 4265.163666161968, 4624.635732458933, 4904.4605093439695, 4925.088858561177, 4490.461144662596, 4916.164252077156, 4964.003976798712, 5106.744662766847, 5392.4607539246545, 4079.8776036718946, 4198.6641068714425, 4470.821167153277, 4839.701141957542, 4974.5771609413605, 2285.8057065149646, 2757.600147978532, 2767.2805070681766, 2781.317303031677, 2793.6254183943893, 5298.986385173609, 5395.514403703685, 5423.074808442946, 5441.564674826004, 5442.619016668795, 4651.813647585629, 4968.29280471368, 5215.921761173586, 5363.490468405495, 5427.185922111715, 4870.4155501340065, 4915.3855768029, 5425.8643533912755, 5426.945730542723, 5556.111022236423, 4699.812007519661, 4901.61305631465, 5289.677580604849, 5297.682388853073, 5340.305760251143, 4130.648894843852, 4422.137683151883, 5050.520200580939, 5255.298001668233, 5579.246801681883, 4557.778632167135, 5707.603975634491, 5745.913811292918, 5797.304323481209, 5845.866258815417, 3702.6852717518236, 3774.3960966245268, 3794.71539634523, 3807.1814559869763, 3839.155385815116, 5674.531578763251, 5684.147377893349, 5689.573282003949, 5702.7718891243885, 5726.914096288476, 4665.440147182224, 5448.591355648263, 5488.423715509974, 5502.174673798802, 5506.191842160447, 5187.365979716377, 5357.19642053695, 5398.514133727984, 5405.486478784509, 5422.430644782399, 4858.684185527929, 5270.367555893317, 5274.70331043098, 5294.788208471772, 5322.414534401135, 4528.622473201595, 4623.745693986863, 4996.451100158963, 5371.5971302153275, 5390.784368625211, 4687.507811679861, 5374.758135883816, 5376.327959005124, 5382.865428364322, 5384.6499977501335], "value": 3876.213315867367, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.9481038922082, 692.2661978302999, 694.2848865668363, 741.0144507804621, 780.6174974262611, 14123.081999670027, 16487.093209873452, 17237.310507579714, 17272.395466158687, 17671.646567068652, 15655.843441565581, 15688.921555392235, 15689.764653530177, 15696.921515392436, 15716.921415392935, 882.814608932125, 908.1009800297691, 911.2846415563783, 912.4160537256129, 912.9360944733871, 899.1952202778509, 902.6885724425063, 903.6837107012559, 926.754410081329, 928.5403725156024, 980.8528720691882, 983.0513554419983, 985.3693636072919, 987.2940847294183, 988.3822610868208, 968.8546717992288, 971.5627967414621, 971.946542940138, 972.2222222222194, 972.3242346569137, 720.2293545905883, 721.6752461392394, 723.1647447198494, 723.7322190789441, 724.8948902409121, 15171.24143792806, 15238.619034524114, 15265.61835954099, 15435.30541125652, 15501.069935803887, 13862.584122476343, 13881.0, 14115.505957291549, 14172.787408188886, 14233.146011239358, 11380.260283081656, 11410.486528106256, 11538.307701537935, 11624.302541847432, 11927.045836333073, 3719.851205951759, 3724.8510059597584, 3739.364308067635, 3824.1395685970433, 3824.2542704172697, 90745.54627226888, 92965.0, 93790.0, 96804.51597742036, 97732.0, 8020.478668886503, 8958.68644597436, 10115.342502737298, 10344.416636872858, 11150.553977840795, 22582.435439113826, 22929.88535057314, 22993.655095173584, 23007.654885176737, 23055.654165187534, 7197.208307086216, 7539.698412063456, 7556.697732090654, 7561.470697051263, 7680.193579674165, 4001.959980400217, 4071.1043570414463, 4104.856330028435, 4255.87232383029, 4303.913921721611, 3524.7356448266482, 3632.3098611263777, 3633.073566240592, 3634.2913131939017, 3638.0541059324764, 600.051917969607, 675.3651567526509, 677.5358879167786, 684.852756657321, 685.8182581615876, 614.0, 624.3039011502142, 625.515225700086, 633.2780630081711, 663.4592806862391, 7918.683252669944, 8465.322774178174, 9203.953980230055, 9344.813103738023, 9583.424994500352, 588.358689028952, 626.4143026270451, 659.591053546804, 667.2360147630935, 684.7808701215563, 4324.632406245441, 4627.213373726475, 4679.3916790816975, 4801.271542244789, 5049.5707864831165, 76642.61678691683, 78002.0, 78569.60715196388, 80812.0, 81885.77171342434, 46274.53725462702, 59170.40829591649, 77636.61181694169, 78605.21394786093, 81237.18762812414, 52990.47009529932, 62702.99999999909, 64360.35639643637, 65045.34954650393, 69772.0, 10134.189264858942, 10204.2346823987, 10225.897741022793, 10303.639372621923, 10408.427536485566, 43846.78076609724, 44423.777881110385, 45164.45066479977, 45646.0, 46787.29819052649, 56764.0, 59212.70393648177, 59285.0, 59814.0, 60270.0, 12481.438335275116, 12664.74670506603, 12905.806412903627, 12983.0, 13096.410661520064, 13854.76528099128, 14229.50196743109, 14475.131492110508, 14698.485553005594, 14772.33524491379, 12937.353132343156, 13102.606921792361, 13210.009249306147, 13251.734965300833, 13777.0, 10020.298579099393, 13184.868151318364, 13335.3332333381, 13660.590182294547, 13960.0, 12815.679608009874, 12849.678758031125, 12964.286964217059, 13154.40805163789, 13543.86456135426, 10632.0, 10853.674389768319, 10891.945540272249, 11102.888971110186, 11207.623963865522, 7307.817304567428, 8357.749267521984, 10987.736410312917, 11266.493007814504, 11460.94269528647], "value": 7287.0136595062, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 111.0, 113.0, 154.0, 114.0, 111.0, 112.0, 115.0, 158.0, 146.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 182.0, 185.0, 181.0, 182.0, 183.0, 182.0, 184.0, 184.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 60.0, 106.0, 84.0, 84.0, 80.0, 61.0, 79.0, 61.0], "value": 75.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 58.0, 89.0, 91.0, 101.0, 81.0, 86.0, 68.0, 68.0, 85.0], "value": 81.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 89.0, 88.0, 89.0, 88.0, 88.0, 88.0, 88.0, 88.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 143.0, 95.0, 96.0, 94.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 100.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 88.0, 88.0, 88.0, 88.0, 87.0, 88.0, 87.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 64.0, 93.0, 117.0, 87.0, 74.0, 70.0, 69.0, 69.0, 72.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 109.0, 117.0, 116.0, 93.0, 93.0, 94.0], "value": 99.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 151.0, 147.0, 152.0, 148.0, 145.0, 144.0, 142.0, 185.0, 165.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 162.0, 218.0, 250.0, 196.0, 185.0, 183.0, 185.0, 183.0, 180.0], "value": 192.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 68.0, 69.0, 69.0, 71.0, 72.0, 82.0, 87.0], "value": 72.5, "unit": "score"}]}]} 22:21:10 INFO - Return code: 0 22:21:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:21:10 ERROR - # TBPL SUCCESS # 22:21:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:21:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:21:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:21:10 INFO - 2017-03-06 22:21:10.515 screenresolution[1653:9990] starting screenresolution argv=screenresolution get 22:21:10 INFO - 2017-03-06 22:21:10.518 screenresolution[1653:9990] Display 0: 1600x1200x32@60 22:21:10 INFO - 2017-03-06 22:21:10.524 screenresolution[1654:9993] starting screenresolution argv=screenresolution list 22:21:10 INFO - Available Modes on Display 0 22:21:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:21:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:21:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:21:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:21:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:21:10 INFO - Intel Iris: 22:21:10 INFO - Chipset Model: Intel Iris 22:21:10 INFO - Type: GPU 22:21:10 INFO - Bus: Built-In 22:21:10 INFO - VRAM (Dynamic, Max): 1536 MB 22:21:10 INFO - Vendor: Intel (0x8086) 22:21:10 INFO - Device ID: 0x0a2e 22:21:10 INFO - Revision ID: 0x0009 22:21:10 INFO - Displays: 22:21:10 INFO - Display: 22:21:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:21:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:21:10 INFO - Display Serial Number: 1600x1200 60 22:21:10 INFO - Main Display: Yes 22:21:10 INFO - Mirror: Off 22:21:10 INFO - Online: Yes 22:21:10 INFO - Rotation: Supported 22:21:10 INFO - Return code: 0 22:21:10 INFO - Running post-action listener: _resource_record_post_action 22:21:10 INFO - [mozharness: 2017-03-07 06:21:10.775434Z] Finished run-tests step (success) 22:21:10 INFO - Running post-run listener: _resource_record_post_run 22:21:10 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 37708800; Write bytes: 554353664; Read time: 237; Write time: 1690 22:21:10 INFO - TinderboxPrint: CPU usage
53.7% 22:21:10 INFO - TinderboxPrint: I/O read bytes / time
37,708,800 / 237 22:21:10 INFO - TinderboxPrint: I/O write bytes / time
554,353,664 / 1,690 22:21:10 INFO - TinderboxPrint: CPU idle
2,232.5 (46.3%) 22:21:10 INFO - TinderboxPrint: CPU system
959.7 (19.9%) 22:21:10 INFO - TinderboxPrint: CPU user
1,625.4 (33.7%) 22:21:10 INFO - TinderboxPrint: Swap in / out
290,082,816 / 0 22:21:10 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 239632896; Write bytes: 226631680; Read time: 17345; Write time: 479 22:21:10 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 31493120; Write bytes: 300770304; Read time: 184; Write time: 1140 22:21:11 INFO - Running post-run listener: _upload_blobber_files 22:21:11 INFO - Blob upload gear active. 22:21:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:21:11 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 22:21:11 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'] 22:21:11 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 22:21:11 INFO - (blobuploader) - INFO - Open directory for files ... 22:21:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:21:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:21:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:12 INFO - (blobuploader) - INFO - Done attempting. 22:21:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:21:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:21:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:13 INFO - (blobuploader) - INFO - Done attempting. 22:21:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:21:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:21:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:14 INFO - (blobuploader) - INFO - Done attempting. 22:21:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:21:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:21:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:17 INFO - (blobuploader) - INFO - Done attempting. 22:21:17 INFO - (blobuploader) - INFO - Iteration through files over. 22:21:17 INFO - Return code: 0 22:21:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:21:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:21:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46bab2b30aa915b680906c3311c8d539e82834046715e3ef2d579aadee155e133b452126ac514f8cb8c48ff889385679955a7e049590e9fd868e2a81bb23876a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c2642a40c3e34020fa173a84ebc5c4a82bd573839a3476db0d53953539020ebb903594ec4490aa9c3f48bc6108430f24aa3337aae8af50c31d14a119c352500", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/165f96e41f40b9adfc56978ec883175d2c872632179520b07637fa5b86b6ccf74a51430ce738b6c44ca376fd1bb93c0c109a0e8bb5aceecf81d75f9f3d0bf1c9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5918944e4f4da76e4f1c77c19e92d155416431d0d1f89ad63b145e38cf5d5bca6b2bc73f898def6b011a6fbe5cfca4b418180962ccb14c85d9a4bb5e2691691c"} 22:21:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:21:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:21:17 INFO - Contents: 22:21:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46bab2b30aa915b680906c3311c8d539e82834046715e3ef2d579aadee155e133b452126ac514f8cb8c48ff889385679955a7e049590e9fd868e2a81bb23876a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c2642a40c3e34020fa173a84ebc5c4a82bd573839a3476db0d53953539020ebb903594ec4490aa9c3f48bc6108430f24aa3337aae8af50c31d14a119c352500", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/165f96e41f40b9adfc56978ec883175d2c872632179520b07637fa5b86b6ccf74a51430ce738b6c44ca376fd1bb93c0c109a0e8bb5aceecf81d75f9f3d0bf1c9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5918944e4f4da76e4f1c77c19e92d155416431d0d1f89ad63b145e38cf5d5bca6b2bc73f898def6b011a6fbe5cfca4b418180962ccb14c85d9a4bb5e2691691c"} 22:21:17 INFO - Running post-run listener: copy_logs_to_upload_dir 22:21:17 INFO - Copying logs to upload dir... 22:21:17 INFO - mkdir: /builds/slave/test/build/upload/logs 22:21:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1293.467149 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2017-03-06 22:21:17.176102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-06 22:21:17.180151) ========= 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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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/46bab2b30aa915b680906c3311c8d539e82834046715e3ef2d579aadee155e133b452126ac514f8cb8c48ff889385679955a7e049590e9fd868e2a81bb23876a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c2642a40c3e34020fa173a84ebc5c4a82bd573839a3476db0d53953539020ebb903594ec4490aa9c3f48bc6108430f24aa3337aae8af50c31d14a119c352500", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/165f96e41f40b9adfc56978ec883175d2c872632179520b07637fa5b86b6ccf74a51430ce738b6c44ca376fd1bb93c0c109a0e8bb5aceecf81d75f9f3d0bf1c9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5918944e4f4da76e4f1c77c19e92d155416431d0d1f89ad63b145e38cf5d5bca6b2bc73f898def6b011a6fbe5cfca4b418180962ccb14c85d9a4bb5e2691691c"} 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.010961 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/46bab2b30aa915b680906c3311c8d539e82834046715e3ef2d579aadee155e133b452126ac514f8cb8c48ff889385679955a7e049590e9fd868e2a81bb23876a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c2642a40c3e34020fa173a84ebc5c4a82bd573839a3476db0d53953539020ebb903594ec4490aa9c3f48bc6108430f24aa3337aae8af50c31d14a119c352500", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/165f96e41f40b9adfc56978ec883175d2c872632179520b07637fa5b86b6ccf74a51430ce738b6c44ca376fd1bb93c0c109a0e8bb5aceecf81d75f9f3d0bf1c9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5918944e4f4da76e4f1c77c19e92d155416431d0d1f89ad63b145e38cf5d5bca6b2bc73f898def6b011a6fbe5cfca4b418180962ccb14c85d9a4bb5e2691691c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-06 22:21:17.218575) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 22:21:17.218962) ========= 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.ZnnrJc5aZs/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.rQn0NHFVg2/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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.005019 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 22:21:17.267662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-06 22:21:17.268025) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-06 22:21:17.268387) ========= ========= Total master_lag: 0.18 =========