builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0033 starttime: 1489854999.1 results: success (0) buildid: 20170318081720 builduid: 3f17cc8a1c6c4cbeb62b25e9a0d8ec7c revision: 1a151f37b7d6b8ce3259e17ad7971a7d4899f55e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-18 09:36:39.097757) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-18 09:36:39.098294) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-18 09:36:39.098632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-18 09:36:39.124440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-18 09:36:39.124847) ========= 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.rdCeAQQW8A/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.sEgoGEaD84/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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-18 09:36:39-- 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% 30.2M=0s 2017-03-18 09:36:39 (30.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.456138 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-18 09:36:39.610503) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-18 09:36:39.611927) ========= 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.rdCeAQQW8A/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.sEgoGEaD84/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.021244 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-18 09:36:39.666078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-18 09:36:39.666521) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1a151f37b7d6b8ce3259e17ad7971a7d4899f55e --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 1a151f37b7d6b8ce3259e17ad7971a7d4899f55e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rdCeAQQW8A/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.sEgoGEaD84/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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-18 09:36:39,751 truncating revision to first 12 chars 2017-03-18 09:36:39,751 Setting DEBUG logging. 2017-03-18 09:36:39,751 attempt 1/10 2017-03-18 09:36:39,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1a151f37b7d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-18 09:36:40,859 unpacking tar archive at: mozilla-central-1a151f37b7d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.370822 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-18 09:36:41.061930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-18 09:36:41.062315) ========= script_repo_revision: 1a151f37b7d6b8ce3259e17ad7971a7d4899f55e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-18 09:36:41.062774) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-18 09:36:41.063125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-18 09:36:41.083785) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-18 09:36:41.084547) ========= /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.rdCeAQQW8A/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.sEgoGEaD84/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:36:41 INFO - MultiFileLogger online at 20170318 09:36:41 in /builds/slave/test 09:36:41 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 09:36:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:36:41 INFO - {'append_to_log': False, 09:36:41 INFO - 'base_work_dir': '/builds/slave/test', 09:36:41 INFO - 'blob_upload_branch': 'Firefox', 09:36:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:36:41 INFO - 'branch': 'Firefox', 09:36:41 INFO - 'buildbot_json_path': 'buildprops.json', 09:36:41 INFO - 'config_files': ('talos/mac_config.py',), 09:36:41 INFO - 'default_actions': ('clobber', 09:36:41 INFO - 'read-buildbot-config', 09:36:41 INFO - 'download-and-extract', 09:36:41 INFO - 'populate-webroot', 09:36:41 INFO - 'create-virtualenv', 09:36:41 INFO - 'install', 09:36:41 INFO - 'run-tests'), 09:36:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:36:41 INFO - 'download_minidump_stackwalk': True, 09:36:41 INFO - 'download_symbols': 'ondemand', 09:36:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:36:41 INFO - 'tooltool.py': '/tools/tooltool.py', 09:36:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:36:41 INFO - '/tools/misc-python/virtualenv.py')}, 09:36:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:36:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:36:41 INFO - 'gecko_profile': False, 09:36:41 INFO - 'gecko_profile_interval': 0, 09:36:41 INFO - 'installer_path': 'installer.exe', 09:36:41 INFO - 'log_level': 'info', 09:36:41 INFO - 'log_name': 'talos', 09:36:41 INFO - 'log_to_console': True, 09:36:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:36:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:36:41 INFO - 'opt_config_files': (), 09:36:41 INFO - 'pip_index': False, 09:36:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:36:41 INFO - 'cmd': ('bash', 09:36:41 INFO - '-c', 09:36:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:36:41 INFO - 'enabled': True, 09:36:41 INFO - 'halt_on_failure': False, 09:36:41 INFO - 'name': 'check_screen_resolution'},), 09:36:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:36:41 INFO - 'cmd': ('bash', 09:36:41 INFO - '-c', 09:36:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:36:41 INFO - 'enabled': True, 09:36:41 INFO - 'halt_on_failure': False, 09:36:41 INFO - 'name': 'check_screen_resolution'},), 09:36:41 INFO - 'run_cmd_checks_enabled': True, 09:36:41 INFO - 'suite': 'dromaeojs', 09:36:41 INFO - 'system_bits': '32', 09:36:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:36:41 INFO - 'title': 't-yosemite-r7-0033', 09:36:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:36:41 INFO - 'use_talos_json': True, 09:36:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:36:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:36:41 INFO - 'work_dir': 'build'} 09:36:41 INFO - [mozharness: 2017-03-18 16:36:41.299948Z] Running clobber step. 09:36:41 INFO - Running pre-action listener: _resource_record_pre_action 09:36:41 INFO - Running main action method: clobber 09:36:41 INFO - rmtree: /builds/slave/test/build 09:36:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:36:44 INFO - Running post-action listener: _resource_record_post_action 09:36:44 INFO - [mozharness: 2017-03-18 16:36:44.476946Z] Finished clobber step (success) 09:36:44 INFO - [mozharness: 2017-03-18 16:36:44.477130Z] Running read-buildbot-config step. 09:36:44 INFO - Running pre-action listener: _resource_record_pre_action 09:36:44 INFO - Running main action method: read_buildbot_config 09:36:44 INFO - Using buildbot properties: 09:36:44 INFO - { 09:36:44 INFO - "project": "", 09:36:44 INFO - "product": "firefox", 09:36:44 INFO - "script_repo_revision": "production", 09:36:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:36:44 INFO - "repository": "", 09:36:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:36:44 INFO - "buildid": "20170318081720", 09:36:44 INFO - "pgo_build": "False", 09:36:44 INFO - "basedir": "/builds/slave/test", 09:36:44 INFO - "buildnumber": 77, 09:36:44 INFO - "slavename": "t-yosemite-r7-0033", 09:36:44 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:36:44 INFO - "platform": "yosemite_r7", 09:36:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:36:44 INFO - "branch": "mozilla-central", 09:36:44 INFO - "repo_path": "mozilla-central", 09:36:44 INFO - "revision": "1a151f37b7d6b8ce3259e17ad7971a7d4899f55e", 09:36:44 INFO - "stage_platform": "macosx64", 09:36:44 INFO - "builduid": "3f17cc8a1c6c4cbeb62b25e9a0d8ec7c", 09:36:44 INFO - "slavebuilddir": "test" 09:36:44 INFO - } 09:36:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:36:44 INFO - Running post-action listener: _resource_record_post_action 09:36:44 INFO - [mozharness: 2017-03-18 16:36:44.481361Z] Finished read-buildbot-config step (success) 09:36:44 INFO - [mozharness: 2017-03-18 16:36:44.481537Z] Running download-and-extract step. 09:36:44 INFO - Running pre-action listener: _resource_record_pre_action 09:36:44 INFO - Running main action method: download_and_extract 09:36:44 INFO - mkdir: /builds/slave/test/build/tests 09:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:44 INFO - trying https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:36:44 INFO - Downloading https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:36:45 INFO - Downloaded 1325 bytes. 09:36:45 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:36:45 INFO - Using the following test package requirements: 09:36:45 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:36:45 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:36:45 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:36:45 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:36:45 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:36:45 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:36:45 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:36:45 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:36:45 INFO - u'jsshell-mac.zip'], 09:36:45 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:36:45 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:36:45 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:36:45 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:36:45 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:36:45 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:36:45 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:36:45 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:36:45 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:36:45 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:36:45 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:36:45 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:36:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:36:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:36:45 INFO - Fetch https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:36:48 INFO - Expected file size: 52475654 09:36:48 INFO - Obtained file size: 52475654 09:37:04 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:37:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:37:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:37:04 INFO - Fetch https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:37:06 INFO - Expected file size: 52475654 09:37:06 INFO - Obtained file size: 52475654 09:37:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:37:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:37:22 INFO - Fetch https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:37:23 INFO - Expected file size: 14404171 09:37:23 INFO - Obtained file size: 14404171 09:37:23 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')]} 09:37:23 INFO - trying https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:37:23 INFO - Downloading https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:37:25 INFO - Downloaded 75117742 bytes. 09:37:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:37:25 INFO - mkdir: /builds/slave/test/properties 09:37:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:37:25 INFO - Writing to file /builds/slave/test/properties/build_url 09:37:25 INFO - Contents: 09:37:25 INFO - build_url:https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:37:26 INFO - Running post-action listener: _resource_record_post_action 09:37:26 INFO - Running post-action listener: set_extra_try_arguments 09:37:26 INFO - [mozharness: 2017-03-18 16:37:26.530463Z] Finished download-and-extract step (success) 09:37:26 INFO - [mozharness: 2017-03-18 16:37:26.530581Z] Running populate-webroot step. 09:37:26 INFO - Running pre-action listener: _resource_record_pre_action 09:37:26 INFO - Running main action method: populate_webroot 09:37:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:37:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:37:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:37:26 INFO - '--tppagecycles', 09:37:26 INFO - '7'], 09:37:26 INFO - 'tests': ['tsvgm']}}, 09:37:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:37:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:37:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:37:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:37:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:37:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:37:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:37:26 INFO - 'talos_options': ['--disable-e10s'], 09:37:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:37:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:37:26 INFO - 'talos_options': ['--disable-e10s'], 09:37:26 INFO - 'tests': ['damp', 'tps']}, 09:37:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:37:26 INFO - 'tests': ['damp', 'tps']}, 09:37:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:37:26 INFO - 'tests': ['dromaeo_dom']}, 09:37:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:37:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:37:26 INFO - 'tests': ['basic_compositor_video']}, 09:37:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:37:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:37:26 INFO - 'tests': ['a11yr', 09:37:26 INFO - 'ts_paint', 09:37:26 INFO - 'tpaint', 09:37:26 INFO - 'sessionrestore', 09:37:26 INFO - 'sessionrestore_no_auto_restore', 09:37:26 INFO - 'tabpaint']}, 09:37:26 INFO - 'other-e10s': {'tests': ['a11yr', 09:37:26 INFO - 'ts_paint', 09:37:26 INFO - 'tpaint', 09:37:26 INFO - 'sessionrestore', 09:37:26 INFO - 'sessionrestore_no_auto_restore', 09:37:26 INFO - 'tabpaint']}, 09:37:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:37:26 INFO - 'ts_paint', 09:37:26 INFO - 'tpaint', 09:37:26 INFO - 'sessionrestore', 09:37:26 INFO - 'sessionrestore_no_auto_restore', 09:37:26 INFO - 'tabpaint']}, 09:37:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:37:26 INFO - 'ts_paint', 09:37:26 INFO - 'tpaint', 09:37:26 INFO - 'sessionrestore', 09:37:26 INFO - 'sessionrestore_no_auto_restore', 09:37:26 INFO - 'tabpaint']}, 09:37:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:37:26 INFO - 'tests': ['a11yr', 09:37:26 INFO - 'ts_paint', 09:37:26 INFO - 'tpaint', 09:37:26 INFO - 'sessionrestore', 09:37:26 INFO - 'sessionrestore_no_auto_restore', 09:37:26 INFO - 'tabpaint']}, 09:37:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:37:26 INFO - 'tests': ['a11yr', 09:37:26 INFO - 'ts_paint', 09:37:26 INFO - 'tpaint', 09:37:26 INFO - 'sessionrestore', 09:37:26 INFO - 'sessionrestore_no_auto_restore', 09:37:26 INFO - 'tabpaint']}, 09:37:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:37:26 INFO - 'tests': ['tsvgx', 09:37:26 INFO - 'tsvgr_opacity', 09:37:26 INFO - 'tart', 09:37:26 INFO - 'tscrollx', 09:37:26 INFO - 'cart', 09:37:26 INFO - 'tsvg_static']}, 09:37:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:37:26 INFO - 'tsvgr_opacity', 09:37:26 INFO - 'tart', 09:37:26 INFO - 'tscrollx', 09:37:26 INFO - 'cart', 09:37:26 INFO - 'tsvg_static']}, 09:37:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:37:26 INFO - 'talos_options': ['--disable-e10s'], 09:37:26 INFO - 'tests': ['tp5o']}, 09:37:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:37:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:37:26 INFO - 'talos_options': ['--disable-e10s', 09:37:26 INFO - '--xperf_path', 09:37:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:26 INFO - 'tests': ['tp5n']}, 09:37:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:37:26 INFO - 'talos_options': ['--xperf_path', 09:37:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:26 INFO - 'tests': ['tp5n']}}, 09:37:26 INFO - 'talos.zip': {'path': '', 09:37:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:37:26 INFO - Running post-action listener: _resource_record_post_action 09:37:26 INFO - [mozharness: 2017-03-18 16:37:26.549092Z] Finished populate-webroot step (success) 09:37:26 INFO - [mozharness: 2017-03-18 16:37:26.549226Z] Running create-virtualenv step. 09:37:26 INFO - Running pre-action listener: _resource_record_pre_action 09:37:26 INFO - Running main action method: create_virtualenv 09:37:26 INFO - Creating virtualenv /builds/slave/test/build/venv 09:37:26 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 09:37:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:37:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:37:26 INFO - Using real prefix '/tools/python27' 09:37:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:37:27 INFO - Installing distribute.............................................................................................................................................................................................done. 09:37:30 INFO - Installing pip.................done. 09:37:30 INFO - Return code: 0 09:37:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:37:30 INFO - Reading from file tmpfile_stdout 09:37:30 INFO - Output received: 09:37:30 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) 09:37:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:37:30 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')]} 09:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:30 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')]} 09:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:30 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 0x105be0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50b5a2410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059bed30>, '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 0x1058e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b3be8>, '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.rdCeAQQW8A/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.sEgoGEaD84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:37:30 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 09:37:30 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 09:37:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdCeAQQW8A/Render', 09:37:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:30 INFO - 'HOME': '/Users/cltbld', 09:37:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:30 INFO - 'LOGNAME': 'cltbld', 09:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:30 INFO - 'MOZ_NO_REMOTE': '1', 09:37:30 INFO - 'NO_EM_RESTART': '1', 09:37:30 INFO - 'PAGER': '/bin/cat', 09:37:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:30 INFO - 'PWD': '/builds/slave/test', 09:37:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:30 INFO - 'SHELL': '/bin/bash', 09:37:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sEgoGEaD84/Listeners', 09:37:30 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:37:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:30 INFO - 'USER': 'cltbld', 09:37:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:30 INFO - 'XPC_FLAGS': '0x0', 09:37:30 INFO - 'XPC_SERVICE_NAME': '0', 09:37:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:30 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 09:37:30 INFO - Cleaning up... 09:37:30 INFO - Return code: 0 09:37:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:37:30 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')]} 09:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:30 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')]} 09:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:30 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 0x105be0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50b5a2410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059bed30>, '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 0x1058e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b3be8>, '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.rdCeAQQW8A/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.sEgoGEaD84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:37:30 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 09:37:30 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 09:37:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdCeAQQW8A/Render', 09:37:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:30 INFO - 'HOME': '/Users/cltbld', 09:37:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:30 INFO - 'LOGNAME': 'cltbld', 09:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:30 INFO - 'MOZ_NO_REMOTE': '1', 09:37:30 INFO - 'NO_EM_RESTART': '1', 09:37:30 INFO - 'PAGER': '/bin/cat', 09:37:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:30 INFO - 'PWD': '/builds/slave/test', 09:37:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:30 INFO - 'SHELL': '/bin/bash', 09:37:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sEgoGEaD84/Listeners', 09:37:30 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:37:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:30 INFO - 'USER': 'cltbld', 09:37:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:30 INFO - 'XPC_FLAGS': '0x0', 09:37:30 INFO - 'XPC_SERVICE_NAME': '0', 09:37:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:31 INFO - Downloading/unpacking psutil>=3.1.1 09:37:31 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 09:37:31 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 09:37:31 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 09:37:31 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 09:37:31 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 09:37:31 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 09:37:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:37:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:35 INFO - Installing collected packages: psutil 09:37:35 INFO - Running setup.py install for psutil 09:37:35 INFO - building 'psutil._psutil_osx' extension 09:37:35 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 09:37:35 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 09:37:35 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 09:37:35 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 09:37:35 INFO - building 'psutil._psutil_posix' extension 09:37:35 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 09:37:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:37:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:37:35 INFO - ^ 09:37:35 INFO - 1 warning generated. 09:37:35 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 09:37:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:36 INFO - Successfully installed psutil 09:37:36 INFO - Cleaning up... 09:37:36 INFO - Return code: 0 09:37:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105be0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50b5a2410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059bed30>, '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 0x1058e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b3be8>, '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.rdCeAQQW8A/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.sEgoGEaD84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:37: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 mozsystemmonitor==0.3 09:37:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdCeAQQW8A/Render', 09:37:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:36 INFO - 'HOME': '/Users/cltbld', 09:37:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:36 INFO - 'LOGNAME': 'cltbld', 09:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:36 INFO - 'MOZ_NO_REMOTE': '1', 09:37:36 INFO - 'NO_EM_RESTART': '1', 09:37:36 INFO - 'PAGER': '/bin/cat', 09:37:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:36 INFO - 'PWD': '/builds/slave/test', 09:37:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:36 INFO - 'SHELL': '/bin/bash', 09:37:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sEgoGEaD84/Listeners', 09:37:36 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:37:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:36 INFO - 'USER': 'cltbld', 09:37:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:36 INFO - 'XPC_FLAGS': '0x0', 09:37:36 INFO - 'XPC_SERVICE_NAME': '0', 09:37:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:37:39 INFO - Installing collected packages: mozsystemmonitor 09:37:39 INFO - Running setup.py install for mozsystemmonitor 09:37:39 INFO - Successfully installed mozsystemmonitor 09:37:39 INFO - Cleaning up... 09:37:39 INFO - Return code: 0 09:37:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:39 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 0x105be0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50b5a2410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059bed30>, '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 0x1058e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b3be8>, '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.rdCeAQQW8A/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.sEgoGEaD84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:37:39 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 09:37:39 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 09:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdCeAQQW8A/Render', 09:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:39 INFO - 'HOME': '/Users/cltbld', 09:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:39 INFO - 'LOGNAME': 'cltbld', 09:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:39 INFO - 'MOZ_NO_REMOTE': '1', 09:37:39 INFO - 'NO_EM_RESTART': '1', 09:37:39 INFO - 'PAGER': '/bin/cat', 09:37:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:39 INFO - 'PWD': '/builds/slave/test', 09:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:39 INFO - 'SHELL': '/bin/bash', 09:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sEgoGEaD84/Listeners', 09:37:39 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:39 INFO - 'USER': 'cltbld', 09:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:39 INFO - 'XPC_FLAGS': '0x0', 09:37:39 INFO - 'XPC_SERVICE_NAME': '0', 09:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:39 INFO - Downloading/unpacking jsonschema==2.5.1 09:37:39 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 09:37:39 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 09:37:39 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 09:37:39 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 09:37:39 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 09:37:39 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 09:37:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:37:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:42 INFO - Downloading functools32-3.2.3-2.tar.gz 09:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:37:42 INFO - warning: no files found matching '*.txt' 09:37:42 INFO - no previously-included directories found matching 'build' 09:37:42 INFO - no previously-included directories found matching 'dist' 09:37:42 INFO - no previously-included directories found matching '.git*' 09:37:42 INFO - Installing collected packages: jsonschema, functools32 09:37:42 INFO - Running setup.py install for functools32 09:37:42 INFO - warning: no files found matching '*.txt' 09:37:42 INFO - no previously-included directories found matching 'build' 09:37:42 INFO - no previously-included directories found matching 'dist' 09:37:42 INFO - no previously-included directories found matching '.git*' 09:37:42 INFO - Successfully installed jsonschema functools32 09:37:42 INFO - Cleaning up... 09:37:42 INFO - Return code: 0 09:37:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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', '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 0x105be0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50b5a2410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059bed30>, '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 0x1058e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b3be8>, '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.rdCeAQQW8A/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.sEgoGEaD84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:37: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:37: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 functools32==3.2.3-2 09:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdCeAQQW8A/Render', 09:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:42 INFO - 'HOME': '/Users/cltbld', 09:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:42 INFO - 'LOGNAME': 'cltbld', 09:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:42 INFO - 'MOZ_NO_REMOTE': '1', 09:37:42 INFO - 'NO_EM_RESTART': '1', 09:37:42 INFO - 'PAGER': '/bin/cat', 09:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:42 INFO - 'PWD': '/builds/slave/test', 09:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:42 INFO - 'SHELL': '/bin/bash', 09:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sEgoGEaD84/Listeners', 09:37:42 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:42 INFO - 'USER': 'cltbld', 09:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:42 INFO - 'XPC_FLAGS': '0x0', 09:37:42 INFO - 'XPC_SERVICE_NAME': '0', 09:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:37:43 INFO - Cleaning up... 09:37:43 INFO - Return code: 0 09:37:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:37:43 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')]} 09:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:43 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')]} 09:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:43 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 0x105be0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50b5a2410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059bed30>, '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 0x1058e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b3be8>, '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.rdCeAQQW8A/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.sEgoGEaD84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:37:43 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 09:37:43 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 09:37:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdCeAQQW8A/Render', 09:37:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:43 INFO - 'HOME': '/Users/cltbld', 09:37:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:43 INFO - 'LOGNAME': 'cltbld', 09:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:43 INFO - 'MOZ_NO_REMOTE': '1', 09:37:43 INFO - 'NO_EM_RESTART': '1', 09:37:43 INFO - 'PAGER': '/bin/cat', 09:37:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:43 INFO - 'PWD': '/builds/slave/test', 09:37:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:43 INFO - 'SHELL': '/bin/bash', 09:37:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sEgoGEaD84/Listeners', 09:37:43 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:37:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:43 INFO - 'USER': 'cltbld', 09:37:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:43 INFO - 'XPC_FLAGS': '0x0', 09:37:43 INFO - 'XPC_SERVICE_NAME': '0', 09:37:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:43 INFO - Downloading/unpacking blobuploader==1.2.4 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:45 INFO - Downloading blobuploader-1.2.4.tar.gz 09:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:37:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:37:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:47 INFO - Downloading docopt-0.6.1.tar.gz 09:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:37:47 INFO - Installing collected packages: blobuploader, requests, docopt 09:37:47 INFO - Running setup.py install for blobuploader 09:37:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:37:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:37:47 INFO - Running setup.py install for requests 09:37:48 INFO - Running setup.py install for docopt 09:37:48 INFO - Successfully installed blobuploader requests docopt 09:37:48 INFO - Cleaning up... 09:37:48 INFO - Return code: 0 09:37:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:48 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')]} 09:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:48 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')]} 09:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:48 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 0x105be0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50b5a2410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059bed30>, '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 0x1058e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b3be8>, '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.rdCeAQQW8A/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.sEgoGEaD84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:37:48 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 09:37:48 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 09:37:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdCeAQQW8A/Render', 09:37:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:48 INFO - 'HOME': '/Users/cltbld', 09:37:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:48 INFO - 'LOGNAME': 'cltbld', 09:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:48 INFO - 'MOZ_NO_REMOTE': '1', 09:37:48 INFO - 'NO_EM_RESTART': '1', 09:37:48 INFO - 'PAGER': '/bin/cat', 09:37:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:48 INFO - 'PWD': '/builds/slave/test', 09:37:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:48 INFO - 'SHELL': '/bin/bash', 09:37:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sEgoGEaD84/Listeners', 09:37:48 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:37:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:48 INFO - 'USER': 'cltbld', 09:37:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:48 INFO - 'XPC_FLAGS': '0x0', 09:37:48 INFO - 'XPC_SERVICE_NAME': '0', 09:37:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:48 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-6k73DC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:48 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-3dcIzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:48 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-kLgIDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:48 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-Q4tJWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:48 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-5Tw8BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:49 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-amyvni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:49 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-kxBOd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:49 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-todUOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:49 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-LwLevT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:49 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-nigUTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:49 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-WViJWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:49 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-coI5eX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:49 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-RNe4wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:49 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-nceO2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:50 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-CawPZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:50 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-WGpxeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:50 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-EiD7wT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:37:50 INFO - Running setup.py install for manifestparser 09:37:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:37:50 INFO - Running setup.py install for mozcrash 09:37:50 INFO - Running setup.py install for mozdebug 09:37:50 INFO - Running setup.py install for mozdevice 09:37:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:37:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:37:50 INFO - Running setup.py install for mozfile 09:37:51 INFO - Running setup.py install for mozhttpd 09:37:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:37:51 INFO - Running setup.py install for mozinfo 09:37:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:37:51 INFO - Running setup.py install for mozInstall 09:37:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:37:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:37:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:37:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:37:51 INFO - Running setup.py install for mozleak 09:37:51 INFO - Running setup.py install for mozlog 09:37:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:37:51 INFO - Running setup.py install for moznetwork 09:37:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:37:52 INFO - Running setup.py install for mozprocess 09:37:52 INFO - Running setup.py install for mozprofile 09:37:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:37:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:37:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:37:52 INFO - Running setup.py install for mozrunner 09:37:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:37:52 INFO - Running setup.py install for mozscreenshot 09:37:52 INFO - Running setup.py install for moztest 09:37:52 INFO - Running setup.py install for mozversion 09:37:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:37:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:37:52 INFO - Cleaning up... 09:37:52 INFO - Return code: 0 09:37:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:52 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')]} 09:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:52 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')]} 09:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:52 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 0x105be0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50b5a2410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059bed30>, '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 0x1058e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b3be8>, '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.rdCeAQQW8A/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.sEgoGEaD84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:37:52 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 09:37:52 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 09:37:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdCeAQQW8A/Render', 09:37:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:52 INFO - 'HOME': '/Users/cltbld', 09:37:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:52 INFO - 'LOGNAME': 'cltbld', 09:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:52 INFO - 'MOZ_NO_REMOTE': '1', 09:37:52 INFO - 'NO_EM_RESTART': '1', 09:37:52 INFO - 'PAGER': '/bin/cat', 09:37:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:52 INFO - 'PWD': '/builds/slave/test', 09:37:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:52 INFO - 'SHELL': '/bin/bash', 09:37:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sEgoGEaD84/Listeners', 09:37:52 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:37:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:52 INFO - 'USER': 'cltbld', 09:37:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:52 INFO - 'XPC_FLAGS': '0x0', 09:37:52 INFO - 'XPC_SERVICE_NAME': '0', 09:37:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:53 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-nLg7GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:53 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)) 09:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:53 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-SvLKu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:53 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)) 09:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:53 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-DUk25B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:53 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)) 09:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:53 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-wuQ_Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:53 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)) 09:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:53 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-g9P1YZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:53 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)) 09:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:53 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-v6D2xC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:53 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)) 09:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:53 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-vtNVU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:53 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)) 09:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:53 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-Owmiim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:54 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)) 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:54 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-X3b0uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:54 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)) 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:54 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-NTvXq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:54 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)) 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:54 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-vHhQSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:54 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)) 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:54 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-nFRucG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:54 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-H4Yeir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:54 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)) 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:54 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-nj2XJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:54 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)) 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:54 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-eEck8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:54 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)) 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:54 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-tWZYa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:54 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)) 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:54 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-tNmmAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:55 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)) 09:37:55 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)) 09:37:55 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)) 09:37:55 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)) 09:37:55 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)) 09:37:55 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)) 09:37:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:37:55 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 09:37:55 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 09:37:55 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 09:37:55 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 09:37:55 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 09:37:55 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 09:37:57 INFO - Downloading blessings-1.6.tar.gz 09:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:37:57 INFO - Installing collected packages: blessings 09:37:57 INFO - Running setup.py install for blessings 09:37:57 INFO - Successfully installed blessings 09:37:57 INFO - Cleaning up... 09:37:58 INFO - Return code: 0 09:37:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:58 INFO - Reading from file tmpfile_stdout 09:37:58 INFO - Current package versions: 09:37:58 INFO - blessings == 1.6 09:37:58 INFO - blobuploader == 1.2.4 09:37:58 INFO - docopt == 0.6.1 09:37:58 INFO - functools32 == 3.2.3-2 09:37:58 INFO - jsonschema == 2.5.1 09:37:58 INFO - manifestparser == 1.1 09:37:58 INFO - mozInstall == 1.12 09:37:58 INFO - mozcrash == 1.0 09:37:58 INFO - mozdebug == 0.1 09:37:58 INFO - mozdevice == 0.49 09:37:58 INFO - mozfile == 1.2 09:37:58 INFO - mozhttpd == 0.7 09:37:58 INFO - mozinfo == 0.9 09:37:58 INFO - mozleak == 0.1 09:37:58 INFO - mozlog == 3.4 09:37:58 INFO - moznetwork == 0.27 09:37:58 INFO - mozprocess == 0.25 09:37:58 INFO - mozprofile == 0.28 09:37:58 INFO - mozrunner == 6.13 09:37:58 INFO - mozscreenshot == 0.1 09:37:58 INFO - mozsystemmonitor == 0.3 09:37:58 INFO - moztest == 0.8 09:37:58 INFO - mozversion == 1.4 09:37:58 INFO - psutil == 3.1.1 09:37:58 INFO - requests == 1.2.3 09:37:58 INFO - wsgiref == 0.1.2 09:37:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:58 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')]} 09:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:58 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')]} 09:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:58 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 0x105be0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50b5a2410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059bed30>, '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 0x1058e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b3be8>, '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.rdCeAQQW8A/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.sEgoGEaD84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:37:58 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 09:37:58 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 09:37:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdCeAQQW8A/Render', 09:37:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:58 INFO - 'HOME': '/Users/cltbld', 09:37:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:58 INFO - 'LOGNAME': 'cltbld', 09:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:58 INFO - 'MOZ_NO_REMOTE': '1', 09:37:58 INFO - 'NO_EM_RESTART': '1', 09:37:58 INFO - 'PAGER': '/bin/cat', 09:37:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:58 INFO - 'PWD': '/builds/slave/test', 09:37:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:58 INFO - 'SHELL': '/bin/bash', 09:37:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sEgoGEaD84/Listeners', 09:37:58 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:37:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:58 INFO - 'USER': 'cltbld', 09:37:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:58 INFO - 'XPC_FLAGS': '0x0', 09:37:58 INFO - 'XPC_SERVICE_NAME': '0', 09:37:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:58 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)) 09:37:58 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)) 09:37:58 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)) 09:37:58 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)) 09:37:58 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)) 09:37:58 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)) 09:37:58 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)) 09:37:58 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)) 09:37:58 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)) 09:37:58 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)) 09:37:58 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)) 09:37:58 INFO - Cleaning up... 09:37:58 INFO - Return code: 0 09:37:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:37:58 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')]} 09:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:58 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')]} 09:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:58 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 0x105be0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50b5a2410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059bed30>, '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 0x1058e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b3be8>, '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.rdCeAQQW8A/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.sEgoGEaD84/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:37:58 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 09:37:58 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 09:37:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdCeAQQW8A/Render', 09:37:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:58 INFO - 'HOME': '/Users/cltbld', 09:37:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:58 INFO - 'LOGNAME': 'cltbld', 09:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:58 INFO - 'MOZ_NO_REMOTE': '1', 09:37:58 INFO - 'NO_EM_RESTART': '1', 09:37:58 INFO - 'PAGER': '/bin/cat', 09:37:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:58 INFO - 'PWD': '/builds/slave/test', 09:37:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:58 INFO - 'SHELL': '/bin/bash', 09:37:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sEgoGEaD84/Listeners', 09:37:58 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:37:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:58 INFO - 'USER': 'cltbld', 09:37:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:58 INFO - 'XPC_FLAGS': '0x0', 09:37:58 INFO - 'XPC_SERVICE_NAME': '0', 09:37:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:37:58 INFO - Cleaning up... 09:37:58 INFO - Return code: 0 09:37:58 INFO - Running post-action listener: _resource_record_post_action 09:37:58 INFO - Running post-action listener: _start_resource_monitoring 09:37:58 INFO - Starting resource monitoring. 09:37:58 INFO - [mozharness: 2017-03-18 16:37:58.937884Z] Finished create-virtualenv step (success) 09:37:58 INFO - [mozharness: 2017-03-18 16:37:58.938867Z] Running install step. 09:37:58 INFO - Running pre-action listener: _resource_record_pre_action 09:37:58 INFO - Running main action method: install 09:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:59 INFO - Reading from file tmpfile_stdout 09:37:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:37:59 INFO - Reading from file tmpfile_stdout 09:37:59 INFO - Output received: 09:37:59 INFO - Usage: mozinstall [options] installer 09:37:59 INFO - Options: 09:37:59 INFO - -h, --help show this help message and exit 09:37:59 INFO - -d DEST, --destination=DEST 09:37:59 INFO - Directory to install application into. [default: 09:37:59 INFO - "/builds/slave/test"] 09:37:59 INFO - --app=APP Application being installed. [default: firefox] 09:37:59 INFO - mkdir: /builds/slave/test/build/application 09:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:38:19 INFO - Reading from file tmpfile_stdout 09:38:19 INFO - Output received: 09:38:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:38:19 INFO - Running post-action listener: _resource_record_post_action 09:38:19 INFO - [mozharness: 2017-03-18 16:38:19.592547Z] Finished install step (success) 09:38:19 INFO - [mozharness: 2017-03-18 16:38:19.592670Z] Running run-tests step. 09:38:19 INFO - Running pre-action listener: _resource_record_pre_action 09:38:19 INFO - Running main action method: run_tests 09:38:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:38:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:38:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:38:19 INFO - 2017-03-18 09:38:19.607 screenresolution[2311:78349] starting screenresolution argv=screenresolution get 09:38:19 INFO - 2017-03-18 09:38:19.609 screenresolution[2311:78349] Display 0: 1600x1200x32@60 09:38:19 INFO - 2017-03-18 09:38:19.615 screenresolution[2312:78351] starting screenresolution argv=screenresolution list 09:38:19 INFO - Available Modes on Display 0 09:38:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:38:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:38:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:38:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:38:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:38:19 INFO - Intel Iris: 09:38:19 INFO - Chipset Model: Intel Iris 09:38:19 INFO - Type: GPU 09:38:19 INFO - Bus: Built-In 09:38:19 INFO - VRAM (Dynamic, Max): 1536 MB 09:38:19 INFO - Vendor: Intel (0x8086) 09:38:19 INFO - Device ID: 0x0a2e 09:38:19 INFO - Revision ID: 0x0009 09:38:19 INFO - Displays: 09:38:19 INFO - Display: 09:38:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:38:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:38:19 INFO - Display Serial Number: 1600x1200 60 09:38:19 INFO - Main Display: Yes 09:38:19 INFO - Mirror: Off 09:38:19 INFO - Online: Yes 09:38:19 INFO - Rotation: Supported 09:38:19 INFO - Return code: 0 09:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:38:19 INFO - Python 2.7.3 09:38:19 INFO - Return code: 0 09:38:19 INFO - grabbing minidump binary from tooltool 09:38:19 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')]} 09:38:19 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 0x1059bed30>, '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 0x1058e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:38:19 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 09:38:19 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 09:38:19 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 09:38:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:38:19 INFO - Return code: 0 09:38:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:38:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:38:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:38:19 INFO - ENV: RUST_BACKTRACE is now 1 09:38:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:38:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:38:19 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://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--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 09:38:19 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://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0033 --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 09:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rdCeAQQW8A/Render', 09:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:19 INFO - 'HOME': '/Users/cltbld', 09:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:19 INFO - 'LOGNAME': 'cltbld', 09:38:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:38:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:19 INFO - 'MOZ_NO_REMOTE': '1', 09:38:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:38:19 INFO - 'NO_EM_RESTART': '1', 09:38:19 INFO - 'PAGER': '/bin/cat', 09:38:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:19 INFO - 'PWD': '/builds/slave/test', 09:38:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:19 INFO - 'RUST_BACKTRACE': '1', 09:38:19 INFO - 'SHELL': '/bin/bash', 09:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sEgoGEaD84/Listeners', 09:38:19 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:19 INFO - 'USER': 'cltbld', 09:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:19 INFO - 'XPC_FLAGS': '0x0', 09:38:19 INFO - 'XPC_SERVICE_NAME': '0', 09:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:19 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://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--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 09:38:20 INFO - mozversion application_buildid: 20170318081720 09:38:20 INFO - mozversion application_changeset: 1a151f37b7d6b8ce3259e17ad7971a7d4899f55e 09:38:20 INFO - mozversion application_display_name: Nightly 09:38:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:38:20 INFO - mozversion application_name: Firefox 09:38:20 INFO - mozversion application_remotingname: firefox 09:38:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:38:20 INFO - mozversion application_vendor: Mozilla 09:38:20 INFO - mozversion application_version: 55.0a1 09:38:20 INFO - mozversion platform_buildid: 20170318081720 09:38:20 INFO - mozversion platform_changeset: 1a151f37b7d6b8ce3259e17ad7971a7d4899f55e 09:38:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:38:20 INFO - mozversion platform_version: 55.0a1 09:38:20 INFO - using testdate: 1489855100 09:38:20 INFO - actual date: 1489855100 09:38:20 INFO - starting webserver on 'localhost:60218' 09:38:20 INFO - SUITE-START | Running 2 tests 09:38:20 INFO - TEST-START | dromaeo_css 09:38:20 INFO - operating with platform_type : mac_ 09:38:20 INFO - Initialising browser for dromaeo_css test... 09:38:20 INFO - TEST-INFO | started process 2322 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpb01Hi0/profile http://localhost:60218/getInfo.html) 09:38:22 INFO - PID 2322 | __metrics Screen width/height:1600/1200 09:38:22 INFO - PID 2322 | colorDepth:24 09:38:22 INFO - PID 2322 | Browser inner width/height: 1024/689 09:38:22 INFO - PID 2322 | __metrics 09:38:22 INFO - PID 2322 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:38:22 INFO - PID 2322 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:23 INFO - TEST-INFO | 2322: exit 0 09:38:23 INFO - Browser initialized. 09:38:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:38:23 INFO - TEST-INFO | started process 2324 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpb01Hi0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:35 INFO - PID 2324 | RSS: Main: 233226240 09:38:35 INFO - PID 2324 | 09:41:39 INFO - PID 2324 | Cycle 1(1): loaded http://localhost:60218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60218/tests/dromaeo/cssquery-ext.html) 09:41:41 INFO - PID 2324 | RSS: Main: 357711872 09:41:41 INFO - PID 2324 | 09:43:25 INFO - PID 2324 | ************************* 09:43:25 INFO - PID 2324 | A coding exception was thrown and uncaught in a Task. 09:43:25 INFO - PID 2324 | 09:43:25 ERROR - PID 2324 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:43:25 INFO - PID 2324 | Full stack: 09:43:25 INFO - PID 2324 | ************************* 09:44:44 INFO - PID 2324 | Cycle 1(1): loaded http://localhost:60218/tests/dromaeo/cssquery-ext.html (next: http://localhost:60218/tests/dromaeo/cssquery-jquery.html) 09:44:45 INFO - PID 2324 | RSS: Main: 387645440 09:44:45 INFO - PID 2324 | 09:47:47 INFO - PID 2324 | Cycle 1(1): loaded http://localhost:60218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60218/tests/dromaeo/cssquery-mootools.html) 09:47:48 INFO - PID 2324 | RSS: Main: 356401152 09:47:48 INFO - PID 2324 | 09:50:50 INFO - PID 2324 | Cycle 1(1): loaded http://localhost:60218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60218/tests/dromaeo/cssquery-prototype.html) 09:50:51 INFO - PID 2324 | RSS: Main: 358936576 09:50:51 INFO - PID 2324 | 09:53:55 INFO - PID 2324 | Cycle 1(1): loaded http://localhost:60218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60218/tests/dromaeo/cssquery-yui.html) 09:53:55 INFO - PID 2324 | RSS: Main: 328355840 09:53:55 INFO - PID 2324 | 09:56:59 INFO - PID 2324 | Cycle 1(1): loaded http://localhost:60218/tests/dromaeo/cssquery-yui.html (next: http://localhost:60218/tests/dromaeo/cssquery-dojo.html) 09:56:59 INFO - PID 2324 | RSS: Main: 465960960 09:56:59 INFO - PID 2324 | 09:56:59 INFO - PID 2324 | __start_tp_report 09:56:59 INFO - PID 2324 | _x_x_mozilla_page_load 09:56:59 INFO - PID 2324 | _x_x_mozilla_page_load_details 09:56:59 INFO - PID 2324 | |i|pagename|runs| 09:56:59 INFO - PID 2324 | |0;dojo.html;2930.6629737580174;3326.0520751585805;3344.916377090571;3360.983195084025;3389;5677.403872593381;5786.1610066540325;5926.407359264077;5941.0494320908665;5988.0718488634275;5847.181394604759;5886.264216972889;5888.470037696607;5958.165856780043;5998.340182579924;4992.750362481879;5169.974150129244;5239.869003274911;5290.338707661543;5291.968066227088;5353.250544923714;5383.865403364908;5393.029254734146;5422.674639521621;5434.619576629638;5209.2446595243855;5263.184206447969;5267.815626453094;5277.419483856773;5345.1982202669715;5253.9474605253845;5254.054270231357;5260.8684782880355;5270.604704647167;5287.339082614673;5178.352705911761;5201.661891977047;5228.947710522884;5233.398159211663;5263.631545791796;5754.4533269339345;5769.278840144982;5775.451332123442;5792.565557583198;5802.390748971382;6254.46837018854;6305.211848518935;6312.747490100391;6322.336154703782;6332.683365831736;6134.816205099513;6188.566800323979;6265.8120256392385;6297.4962003039645;6305.243370795534;6014.78948236814;6021.187139736124;6035.124906888476;6039.335673075958;6072.301685306158;5864.736086876101;6354.523410744213;6383.329750376237;6388.904166437507;6407.871842563122;5731.398203188689;6205.100260462298;6205.906911396332;6266.624002559861;6295.150154729053;6253.280872699606;6260.530460215502;6270.372962703785;6273.62358258506;6286.591371560926;6225.750969961151;6242.313345531988;6248.343923887926;6259;6287.371262873676;6104.0347610180015;6179.258488981351;6216.875662486725;6244.094606282064;6261.686915654199;5115.411727651293;5117.181250999822;5137.717425541557;5138.30632864566;5153.1497302945345;4519.954800452019;4523.411956445641;4544.931826022612;4560.5895469407915;4586.6789324747615;5663.518600918968;5743.54051675865;5895.056790913433;5944.524438044946;5959.67221802805;6238.781642642576;6257.342978987232;6262.812115636447;6273.435390814849;6284.717187726564;5885.323187833454;5899.144624029492;5905.143754155623;5906.8818623627285;5907.084401917709;5539.307586551681;5542.39033706292;5560.110382338807;5569.220309156722;5574.498295153375;6140.320203811546;6236.314005459487;6260.248770147611;6264.248290205204;6268.341824108403;6217.036359364306;6240.7503699851495;6249.750009999549;6250.843728906631;6278.591891527036;6352.460040896575;6360.968195158995;6377.1390862233;6390.5526613136635;6402.295747467868;6262.373762623702;6267.435930766253;6286.371362863677;6288.025356069817;6293.181886354744;5245.790168393374;6153.077038444269;6177.876442471215;6249.312575616769;6278.748850045947;6158.784442544668;6226.315105338319;6247.031710084944;6255.061740738925;6267.874642507216;6199.039148931743;6219.968900155471;6243.282022567281;6248.656323902229;6258.186435763321;5950.761969521343;6004.759809607567;6116.66358350295;6124.724387402489;6127.417895299939;6157.907631385622;6215.751369945152;6267.2479302484;6269.843253918689;6278.560500765086;6077.756889724538;6116.17431646722;6116.5106791457465;6137.631742095488;6152.292486363946 09:56:59 INFO - PID 2324 | |1;ext.html;768.2356055724554;788.8461749958758;846.7883029242689;860.7675927499575;863.9265662418694;36104.91685249443;36506.817465912696;36538;36558;36562.45156322654;37315.62684373155;37562.8121859391;37675.999999999935;37687.81156094216;37809.0547736306;7147.106611673541;7842.647080881374;9182;9203.309751768611;9220.953895230514;7202.747903823367;7307.415406767473;7314.378277846389;7318.3047610476915;7320.341169294762;10577.259591828575;10785.46072696362;10802.51388687511;10805.83791243132;10816;10791.62229321974;10837.18721095921;10887.945560272188;10892.40091794951;10910.836337454944;7088.503804733671;7215.567065976058;10512.316699414514;10607.628732994386;10633.78732425355;35882.82058589716;36065.918022459366;36084.63915360865;36112.819435902915;36232.9273901654;3315.5689760331;3722.8696995605296;3761.9435708464393;3778.3010143123333;3794.7912864792424;26004.829782659825;26510.728995364545;26538.20385388422;27334.863325683444;27562.621868906474;3086.382723455318;3117.8441077946013;3207.2142325130494;3215.4855223164413;3242.205659613386;304266.4786676075;304854;304901;305217;305692;37437.81281093577;38478.03804904844;50594.49405505972;50702.6340653788;50825.491745082814;40505.55702765239;40578.98552536151;40715.77852664425;40730.592694073275;40734;13817;13860.653483662989;13864.792028119586;13895.930520347334;13897.86102138986;11428.657140285804;11453.656390308304;11476.942615287036;11477.770444591062;11483.598074067535;12194.207376520499;12231.510739570496;12328.630141095782;12341.50633974631;12367.69080772988;4966.478519755374;5473.589480788957;5615.157726341082;5615.971920140455;5642.379338272786;1031.9380837149795;1041.2151828104893;1054.5623566219933;1055.7518983038979;1084.6312253833735;26558.203253902415;26581.734182658314;26811.329716756845;27154.86422567914;27290.5906411404;1031.28841099641;1038.6520515627199;1110.5502271580024;1152.9884701153048;1164.7670465906851;13176.47294108244;13635.977301702413;13930.233837139054;14005.929970350084;14017;429907;430146;430180;430574;430589;54210.72894635502;54228.72885635547;54274;54306;54397.72801136048;1346.8181795457488;1435.8564143585559;1439.2084353605685;1441.7981482592445;1444.4366696988184;24220.75779242185;25028.24915252545;26002.21993340203;26074.478510430064;26143.477130457664;43728.781356093015;43869.561304386545;43915.90210244642;44026.11947760963;44104.33843492286;391467;391598;393569;394278;394440.5837387033;31849.522257166624;32458.86393976294;32475.512867306537;32483.512747309283;32654.34691306113;30562.694373055983;33437.498437523944;38165.61834381732;38609.613903860605;42455.93860153521;30473.61975456767;32944.67055329512;33011.66988330182;34716;35327.11682207965;33500.664993349754;33505.83247083749;33957.830210848784;34833;34962.47556286607;25235.621465678396;34944.65055349414;34979.47530786989;35020.82489587638;35119.824400877835;23824.642630360213;26255.343616409744;29943.85028074846;30040.399192016474;30070;20445.661844827555;21955.560888782453;23104.768952310933;23400.414989625395;23523.764762352843 09:56:59 INFO - PID 2324 | |2;jquery.html;370.8182990334737;396.18979187561416;413.673198173443;414.2419372548237;432.27809558038075;18801;19856.90071549642;20878.582428351423;21077.946102694863;21206.469838254034;21920.23279185229;22232.333030009086;22438.775612243873;23299.883500582517;23545.882270588623;6462.483001359892;6876.1748590169245;6881.41507971823;6894.207166175879;6900.5859648421;6167.938320616804;6608.173978252718;6687.531872768908;6759.966200168992;6764.222114456827;6417.967910160442;6743.932560674404;6750.021246919194;6753.3921947024755;6774.695138718769;6584.703688334012;6738.258791532977;6747.595144291309;6749.088873002155;6757.121574195372;6293.685315734195;6365.236171659384;6507.219133703986;6520.054592084169;6520.250171230322;26790.73209267902;26919.461610767674;26927;27051.59422608643;27247.318817029536;3276.3611095836322;3381.6449272826244;3391.0844072100394;3449.2066824630474;3487.093355727504;16523.091229982347;17236.82763172365;17248.39630612935;17277.30890764368;17278.91360543202;1897.73431719558;1992.402279316214;1993.5713821528295;1994.4814348269554;2063.9793602063937;143449.8482522763;148445;154050;154314;154512.99999999886;18583.106267029973;20662.380128596167;20729;20901.79098209029;21058.2629607963;33948.32103357919;33979.49030764541;34070.65929340725;34133;34293.314133717686;8100.311473524816;8686.826263474695;9936.80126397468;10123.341982771097;10145.34055286404;8335.416520843482;8354.916450835413;8362.24739773411;8527.573621318908;8594.441361311494;7956.840863182704;9501.714948551555;9699.903000970042;9860.359076659994;9888.116570640457;3510.5962814276686;3543.875964341236;4080.8571699990357;4092.6112019358116;4100.17996400721;800.9199080091944;891.0955380289012;910.9544522773834;922.4880191493785;947.4646824544111;22212.444688882908;22803.543929121326;22969.655455168187;23202;23784.04863805463;762.4205603741196;837.0744248850186;889.8709687095464;932.5523748600709;951.8143961927497;9991.734138010117;11279.774404511863;11811.704707382385;12021.939890300668;12068.396580170956;659512;660394;672457;691343;691945.2651998053;129457;134241;144484;148578;149057;1207.221342234254;1223.932683702387;1247.4947646203302;1252.1360261419773;1257.1074537078593;19059.475241980886;19807.910564918493;19852.404427867186;19898.104585293408;19915.60168796645;43298;45355.54644453645;58611.12083318668;63114.73770524472;63744;86528.8257778318;87835.56082219804;88347;89316;90344.54827725819;10854.240203186017;11022.44887755593;11396.316221026766;11595.652130436101;12101.75796484083;13562.457501699822;13603.455861765418;13752.174869507862;14139.717205655623;14149.717005659622;11611.477483513094;11687.298762074302;11697.473613687574;11938.343391113573;11993.880061199276;11487.885121148682;11503.76992460163;11617.767644647229;11635.41822908868;11829.76340473203;11373.090152787592;11764.941175294069;11877.76244475123;12067.336296503776;12091.39543022863;11686.94156529212;11688.590899318484;11971.0247809114;11985.580504682293;12059.939700301442;9462.716118516455;11586.131040171853;11916.880831191576;11956.940215298868;11968.042556595625 09:56:59 INFO - PID 2324 | |3;mootools.html;1358.592422273319;1561.375449820072;1579.2735341742798;1600.5358446050645;1656.7680524726536;9001.819963600732;9419.48192849393;10733.83899241512;10891.782164356708;10901.400422976732;10626.990435908576;10716.35701857887;10727.302725322848;10728.249022568423;10745.946270268658;2308.4228942764353;2357.669926210332;2359.0210062823908;2361.3624321433203;2370.502194539149;1956.9510762230916;2037.0120491561581;2042.3770749921343;2042.4995876010398;2328.359701082199;2007.217185297735;2016.4555569996091;2278.4303924018996;2344.4842134730334;2360.5042940982416;2321.1643808229023;2324.755900630443;2328.452813588822;2329.650552417134;2331.6385960176117;2222.811061059812;2309.030207312933;2312.09828167015;2320.582295186866;2321.1063740459876;10881.891181088167;11004.724881877937;11013.669589912315;11024.724381890437;11077.224594278403;5417.891642167174;5625.8593535161535;5628.859278518029;5646.661200327952;5656.349519805234;2966.9274571501896;3381.2730262993327;3454.896353109411;3506.544149260605;3606.675399214057;1171.08070164921;1175.6061719324036;1220.2373516552154;1234.456838990841;1235.8146278058273;14951.626209344744;15043.924780376137;15099.622509437242;15109.924450377897;15174.772378414333;4707.964247865532;4721.834735784231;4810.879728006757;4848.8302909398;4927.679700819435;12494;12497.50009999608;12502.062345324137;12508.812367814307;12521.749565008831;5882.588218824641;5889.764409423661;5899.056151015902;5900.586958912921;5904.232449781501;5075.695458272442;5157.149070403417;5161.922571161435;5215.817446389358;5216.869578260574;3573.1960308930284;3834.539855217392;3923.685025834714;4003.559608443069;4013.9328245953357;980.5734505490135;1039.2050081687514;1053.4153544782719;1089.5206109311878;1144.9656510304703;928.7538802217417;943.613118621362;950.2825366847985;953.8378475659155;975.3224453939213;6110.816675499653;6270.435660790551;6466.902996455057;6608.537402381787;6713.0937323461685;1010.9090181883665;1012.4532752313668;1013.6300250408548;1028.99485502572;1029.4235228272191;4241.045764702917;4265.338872474771;4285.442892423965;4401.537838526972;4422.889427764331;13220.140690855063;13677.31613419325;13680.726385472235;13688.452461901412;13693.589192324247;12806.871931280568;13211;13500.392482338319;13572.728545429036;13683.86316136826;9816.838126393082;9821.656242031495;9853.408795472295;9929;9990.15083717892;6273.96863015682;6361.777337793155;6468.417842394207;6714.6978385973725;6774.187097548326;11796.882031179579;12169.513219471122;12230.388480575757;12235.877641223475;12309.076819238771;12156.452959616661;12335.074869384653;12521.56174533887;12666.746665066463;12828.358582071045;8233.135520770473;8405.411621186458;8418.6211620476;8419.747407577783;8428.704995325133;9875.061869122423;9930.702078937644;10029.849552256575;10030.799384012133;10100.838403583683;8428.873566896624;8572.014218364719;8601.870971935552;8767.254783343487;8821.294296456397;8485.703000394957;8485.91514084876;8574.442661227;8621.87067194005;8634.481931084156;7648.885266721115;7801.258880406353;7820.84358312842;7830.3735701144915;7833.686652533835;5697.287839020122;5716.314042314949;5838.503727183237;5910.379410162043;5954.583179177589;5697.943020569741;5726.2269593606;5945.197398351167;6025.915335239523;6056.364081771527 09:56:59 INFO - PID 2324 | |4;prototype.html;370.27426244560667;370.4517314374725;386.1003861003861;386.9071422858513;387.4517557655917;4890.975545122269;5856.590038697287;5895.941040589592;5910.88178236435;5922.230110085683;5449.373322067963;5726.455986681269;5771;5820.476157145856;5825.1844741736195;4072.735272207312;4769.499202583731;4774.379330687015;4784.234522476387;4785.306130611059;3879.689624830007;3920.1963597462595;4827.203511420611;4827.541383568555;4869;4653.557911998355;4704.858854234379;4742.383490146276;4764.928526072112;4818.59041981432;3567.9643203567894;4146.419501269825;4725.243960966229;4749.670092374124;4752.289175896674;3658.9634103659155;4354.56144559048;4367.71609845359;4372;4406.669499787528;4435.667324950641;5645.745941432604;5651.9152212716845;5729.369769325371;5766.079066234958;5518.33779946405;5525.817302165662;5536.972315138439;5538.667679939216;5550.91673624896;5215.24378965048;5949.553783466257;6224.62652240867;6263.906041409337;6272.968635156795;4827.758612069382;4889.975550122263;4925.3350797642215;4931.791711030821;4934.136526107953;6244.625322480666;6445.548811583144;6458.289588145253;6552.410283074546;6648.66756662165;4929.137400954819;5040.344755181803;5068;5075.238714192827;5106.54463477907;5183.196604526304;5189.065968125774;5191.143461328838;5215.791368345223;5238.537887193013;4639.350490931272;5141.5886729061585;5364.91952620711;5456.772226249062;5566.471185237396;5134.510991812407;5494.2582751328855;6042.516598672096;6240.687965601702;6286.622802631857;1724.7499112628598;1764.1884733022696;1775.6448710258;1794.9820501795075;1795.1293622593032;1155.664857191405;1273.8789814967563;1275.1775105057186;1303.2180691584974;1326.476041963419;5858.740370820294;5860;5866.501347385435;5871.500922421642;5894.204282421818;5528.391876893538;5640;6440.488209598167;6473.352664733583;6473.643949582818;5187.974060129675;5688.459596338424;5848.210491583582;5879.441453061952;5885.264341957255;3220.388126256004;3330.733541316689;3369.882054128143;3384.3569721752788;3391.9152021199666;6428.742850285937;6560.507961902781;6666.699998500079;6667.399934005963;6676.732930682815;6589.472842172615;6617.86383510306;6620.139381880324;6643.900341494881;6667.266600673922;5841.88316233673;6097.932861749265;6165.84585385369;6350.650714210763;6643.60138391698;6003.219581454383;6090.969545152423;6378.617282963037;6383.446621351496;6426.710798014195;5082.059818933509;5323.494268044529;6098.481629061579;6311.936880631135;6376.202974628171;6122.5408094392205;6171.59884607499;6473.643949582818;6615.702293396905;6690.732370705117;4461.486929003207;5029.748512574283;5035.647504674637;5082.136036873814;5106.361704786902;6256.530760192913;6388.329225431263;6393.808185754248;6420.646864422315;6439.935600644121;5289.788408463773;6192.411720886508;6210.720517576629;6211.689005899891;6220.906686399617;4638.744869032235;4899.216125419915;5449.782008719607;5521.282233309644;5883.499902508334;4883.682560633548;5802;6052.667103309184;6083.482903953213;6087.391260874055;6222.844428889314;6225.284092329259;6245.344238854855;6247.282432142033;6255.624662520263;5311.867203319948;5742.339630942495;5988.850278743066;6042.637441753509;6135.07973803933 09:56:59 INFO - PID 2324 | |5;yui.html;710.9928900710992;715.7316006497564;726.9963650181749;761.847630473905;803.4215364937247;14790.260486975649;15459.922700386496;15497.92251038746;15619.297131629075;15813.920930395361;13975.580732578039;14325.498607548738;14595.92702036491;14637.560873173796;14923.776143357858;920.6179435534262;946.7254496196094;948.3077353531926;950.8621249918758;951.1202138022336;930.9813803723921;947.8767760191165;969.7672558585924;974.1281553010052;974.9415035097882;1002.298391126211;1020.7193021918957;1023.2428003277558;1023.9590416383336;1026.7279171019686;1012.1649639047778;1017.099866618041;1019.3730855523836;1019.3934608907688;1022.4223313827738;760.9010828592303;763.4198009512754;763.6067425275987;763.8777795552685;764.8814433762776;15528.844711552852;15561.144137072457;15867.365305387772;16135.435259765853;16188.190590470429;14376.424943002268;14586.827298077853;14600.926995364955;14711;14762.261886905719;11413.486393112247;11520.884791152064;11712.765744685059;11729.70675733105;12060.396980150957;3580.5524309461316;3644.380455322575;3854.4603755474254;3859.8842034739005;3870.2646497165447;99742.50128749383;102762;102998;104917.67549681939;105209.89580208353;10728.731781705364;10909.890901091047;11283.887161128448;11417.257878237888;11559.653210403701;24339;24549.140780072612;24837.254882353558;24878.5024299513;24891.875540622183;7456.552606843607;7661.31048205653;7765.7670269892;7796;7946.218823411759;4204.810783514749;4234.767087810138;4257.5233845019975;4361.738295702268;4389.780510974439;3377.8986630401128;3493.703035242033;3495.685388315064;3496.0910163357203;3497.8600855965983;621.254494606474;626.3517259636254;645.270843946347;645.4836131095105;648.2609824799732;656.3600489522772;682.7883356159606;692.8648913461826;704.8766465868453;708.1855865754321;8132.534634965217;9405.482698451651;9499.430034197832;9965.152961998167;10157;629.8456878064903;642.1267076775581;659.9340065993363;695.5583204665074;695.9025736396909;4274.21867658475;4457.955420445754;4502.5047244803045;4712.481627021025;4726.71639701619;87816;95685.52157239309;96385;97734.0226597725;100694.49652751836;60475;81100.18899810927;81220;85098;85481.57259213664;71012;71713;74030.25969740341;74511.62744186244;75101;9172.862407063765;9211.493367864563;9260;9273.397229180082;9296.349255552317;36513.087172820895;44978.3253251195;47238.371366442276;47796;48049;63245.36754632395;63249.36750632435;63308.417289566285;63551.0467342981;64584.67707661619;11515.136364772508;11633.941830291133;11666.76666466649;11707.239029463057;11737.823932641188;12531.87468125307;12646.683832904251;12749.553765618159;12849.421776020288;12940.482380704667;11607.477663505331;12203.328816915155;12204;12214.26714397139;12389.008879289455;11170.329780213213;11538.94230528842;11659.53361865516;11866.644000679993;12039.63881083569;11189.328640281608;11468.885311147116;11883.940580297043;11934.880651193724;11943.04455643529;9674.661386851427;9733.367331123454;9765.41407515523;9794.510274486105;10051.297375367183;9244.815103698023;9656.9034309656;9659.806803863743;9679.951600241953;9688.75778105553 09:56:59 INFO - PID 2324 | __end_tp_report 09:56:59 INFO - PID 2324 | __start_cc_report 09:56:59 INFO - PID 2324 | _x_x_mozilla_cycle_collect,1870 09:56:59 INFO - PID 2324 | __end_cc_report 09:56:59 INFO - PID 2324 | __startTimestamp1489856219595__endTimestamp 09:56:59 INFO - PID 2324 | 09:56:59 INFO - PID 2324 | ------- Summary: start ------- 09:56:59 INFO - PID 2324 | Number of tests: 6 09:56:59 INFO - PID 2324 | 09:56:59 INFO - PID 2324 | [#0] dojo.html Cycles:165 Average:5824.06 Median:6116.17 stddev:644.77 (10.5%) stddev-sans-first:605.48 09:56:59 INFO - PID 2324 | Values: 2930.7 3326.1 3344.9 3361.0 3389.0 5677.4 5786.2 5926.4 5941.0 5988.1 5847.2 5886.3 5888.5 5958.2 5998.3 4992.8 5170.0 5239.9 5290.3 5292.0 5353.3 5383.9 5393.0 5422.7 5434.6 5209.2 5263.2 5267.8 5277.4 5345.2 5253.9 5254.1 5260.9 5270.6 5287.3 5178.4 5201.7 5228.9 5233.4 5263.6 5754.5 5769.3 5775.5 5792.6 5802.4 6254.5 6305.2 6312.7 6322.3 6332.7 6134.8 6188.6 6265.8 6297.5 6305.2 6014.8 6021.2 6035.1 6039.3 6072.3 5864.7 6354.5 6383.3 6388.9 6407.9 5731.4 6205.1 6205.9 6266.6 6295.2 6253.3 6260.5 6270.4 6273.6 6286.6 6225.8 6242.3 6248.3 6259.0 6287.4 6104.0 6179.3 6216.9 6244.1 6261.7 5115.4 5117.2 5137.7 5138.3 5153.1 4520.0 4523.4 4544.9 4560.6 4586.7 5663.5 5743.5 5895.1 5944.5 5959.7 6238.8 6257.3 6262.8 6273.4 6284.7 5885.3 5899.1 5905.1 5906.9 5907.1 5539.3 5542.4 5560.1 5569.2 5574.5 6140.3 6236.3 6260.2 6264.2 6268.3 6217.0 6240.8 6249.8 6250.8 6278.6 6352.5 6361.0 6377.1 6390.6 6402.3 6262.4 6267.4 6286.4 6288.0 6293.2 5245.8 6153.1 6177.9 6249.3 6278.7 6158.8 6226.3 6247.0 6255.1 6267.9 6199.0 6220.0 6243.3 6248.7 6258.2 5950.8 6004.8 6116.7 6124.7 6127.4 6157.9 6215.8 6267.2 6269.8 6278.6 6077.8 6116.2 6116.5 6137.6 6152.3 09:56:59 INFO - PID 2324 | 09:56:59 INFO - PID 2324 | [#1] ext.html Cycles:180 Average:51024.90 Median:32799.51 stddev:100555.07 (306.6%) stddev-sans-first:100766.35 09:56:59 INFO - PID 2324 | Values: 768.2 788.8 846.8 860.8 863.9 36104.9 36506.8 36538.0 36558.0 36562.5 37315.6 37562.8 37676.0 37687.8 37809.1 7147.1 7842.6 9182.0 9203.3 9221.0 7202.7 7307.4 7314.4 7318.3 7320.3 10577.3 10785.5 10802.5 10805.8 10816.0 10791.6 10837.2 10887.9 10892.4 10910.8 7088.5 7215.6 10512.3 10607.6 10633.8 35882.8 36065.9 36084.6 36112.8 36232.9 3315.6 3722.9 3761.9 3778.3 3794.8 26004.8 26510.7 26538.2 27334.9 27562.6 3086.4 3117.8 3207.2 3215.5 3242.2 304266.5 304854.0 304901.0 305217.0 305692.0 37437.8 38478.0 50594.5 50702.6 50825.5 40505.6 40579.0 40715.8 40730.6 40734.0 13817.0 13860.7 13864.8 13895.9 13897.9 11428.7 11453.7 11476.9 11477.8 11483.6 12194.2 12231.5 12328.6 12341.5 12367.7 4966.5 5473.6 5615.2 5616.0 5642.4 1031.9 1041.2 1054.6 1055.8 1084.6 26558.2 26581.7 26811.3 27154.9 27290.6 1031.3 1038.7 1110.6 1153.0 1164.8 13176.5 13636.0 13930.2 14005.9 14017.0 429907.0 430146.0 430180.0 430574.0 430589.0 54210.7 54228.7 54274.0 54306.0 54397.7 1346.8 1435.9 1439.2 1441.8 1444.4 24220.8 25028.2 26002.2 26074.5 26143.5 43728.8 43869.6 43915.9 44026.1 44104.3 391467.0 391598.0 393569.0 394278.0 394440.6 31849.5 32458.9 32475.5 32483.5 32654.3 30562.7 33437.5 38165.6 38609.6 42455.9 30473.6 32944.7 33011.7 34716.0 35327.1 33500.7 33505.8 33957.8 34833.0 34962.5 25235.6 34944.7 34979.5 35020.8 35119.8 23824.6 26255.3 29943.9 30040.4 30070.0 20445.7 21955.6 23104.8 23400.4 23523.8 09:56:59 INFO - PID 2324 | 09:56:59 INFO - PID 2324 | [#2] jquery.html Cycles:180 Average:40643.27 Median:26855.10 stddev:112901.60 (420.4%) stddev-sans-first:113177.83 09:56:59 INFO - PID 2324 | Values: 370.8 396.2 413.7 414.2 432.3 18801.0 19856.9 20878.6 21077.9 21206.5 21920.2 22232.3 22438.8 23299.9 23545.9 6462.5 6876.2 6881.4 6894.2 6900.6 6167.9 6608.2 6687.5 6760.0 6764.2 6418.0 6743.9 6750.0 6753.4 6774.7 6584.7 6738.3 6747.6 6749.1 6757.1 6293.7 6365.2 6507.2 6520.1 6520.3 26790.7 26919.5 26927.0 27051.6 27247.3 3276.4 3381.6 3391.1 3449.2 3487.1 16523.1 17236.8 17248.4 17277.3 17278.9 1897.7 1992.4 1993.6 1994.5 2064.0 143449.8 148445.0 154050.0 154314.0 154513.0 18583.1 20662.4 20729.0 20901.8 21058.3 33948.3 33979.5 34070.7 34133.0 34293.3 8100.3 8686.8 9936.8 10123.3 10145.3 8335.4 8354.9 8362.2 8527.6 8594.4 7956.8 9501.7 9699.9 9860.4 9888.1 3510.6 3543.9 4080.9 4092.6 4100.2 800.9 891.1 911.0 922.5 947.5 22212.4 22803.5 22969.7 23202.0 23784.0 762.4 837.1 889.9 932.6 951.8 9991.7 11279.8 11811.7 12021.9 12068.4 659512.0 660394.0 672457.0 691343.0 691945.3 129457.0 134241.0 144484.0 148578.0 149057.0 1207.2 1223.9 1247.5 1252.1 1257.1 19059.5 19807.9 19852.4 19898.1 19915.6 43298.0 45355.5 58611.1 63114.7 63744.0 86528.8 87835.6 88347.0 89316.0 90344.5 10854.2 11022.4 11396.3 11595.7 12101.8 13562.5 13603.5 13752.2 14139.7 14149.7 11611.5 11687.3 11697.5 11938.3 11993.9 11487.9 11503.8 11617.8 11635.4 11829.8 11373.1 11764.9 11877.8 12067.3 12091.4 11686.9 11688.6 11971.0 11985.6 12059.9 9462.7 11586.1 11916.9 11956.9 11968.0 09:56:59 INFO - PID 2324 | 09:56:59 INFO - PID 2324 | [#3] mootools.html Cycles:180 Average:6640.82 Median:3174.10 stddev:4181.00 (131.7%) stddev-sans-first:4173.89 09:56:59 INFO - PID 2324 | Values: 1358.6 1561.4 1579.3 1600.5 1656.8 9001.8 9419.5 10733.8 10891.8 10901.4 10627.0 10716.4 10727.3 10728.2 10745.9 2308.4 2357.7 2359.0 2361.4 2370.5 1957.0 2037.0 2042.4 2042.5 2328.4 2007.2 2016.5 2278.4 2344.5 2360.5 2321.2 2324.8 2328.5 2329.7 2331.6 2222.8 2309.0 2312.1 2320.6 2321.1 10881.9 11004.7 11013.7 11024.7 11077.2 5417.9 5625.9 5628.9 5646.7 5656.3 2966.9 3381.3 3454.9 3506.5 3606.7 1171.1 1175.6 1220.2 1234.5 1235.8 14951.6 15043.9 15099.6 15109.9 15174.8 4708.0 4721.8 4810.9 4848.8 4927.7 12494.0 12497.5 12502.1 12508.8 12521.7 5882.6 5889.8 5899.1 5900.6 5904.2 5075.7 5157.1 5161.9 5215.8 5216.9 3573.2 3834.5 3923.7 4003.6 4013.9 980.6 1039.2 1053.4 1089.5 1145.0 928.8 943.6 950.3 953.8 975.3 6110.8 6270.4 6466.9 6608.5 6713.1 1010.9 1012.5 1013.6 1029.0 1029.4 4241.0 4265.3 4285.4 4401.5 4422.9 13220.1 13677.3 13680.7 13688.5 13693.6 12806.9 13211.0 13500.4 13572.7 13683.9 9816.8 9821.7 9853.4 9929.0 9990.2 6274.0 6361.8 6468.4 6714.7 6774.2 11796.9 12169.5 12230.4 12235.9 12309.1 12156.5 12335.1 12521.6 12666.7 12828.4 8233.1 8405.4 8418.6 8419.7 8428.7 9875.1 9930.7 10029.8 10030.8 10100.8 8428.9 8572.0 8601.9 8767.3 8821.3 8485.7 8485.9 8574.4 8621.9 8634.5 7648.9 7801.3 7820.8 7830.4 7833.7 5697.3 5716.3 5838.5 5910.4 5954.6 5697.9 5726.2 5945.2 6025.9 6056.4 09:56:59 INFO - PID 2324 | 09:56:59 INFO - PID 2324 | [#4] prototype.html Cycles:180 Average:5178.25 Median:5558.69 stddev:1461.85 (26.3%) stddev-sans-first:1420.71 09:56:59 INFO - PID 2324 | Values: 370.3 370.5 386.1 386.9 387.5 4891.0 5856.6 5895.9 5910.9 5922.2 5449.4 5726.5 5771.0 5820.5 5825.2 4072.7 4769.5 4774.4 4784.2 4785.3 3879.7 3920.2 4827.2 4827.5 4869.0 4653.6 4704.9 4742.4 4764.9 4818.6 3568.0 4146.4 4725.2 4749.7 4752.3 3659.0 4354.6 4367.7 4372.0 4406.7 4435.7 5645.7 5651.9 5729.4 5766.1 5518.3 5525.8 5537.0 5538.7 5550.9 5215.2 5949.6 6224.6 6263.9 6273.0 4827.8 4890.0 4925.3 4931.8 4934.1 6244.6 6445.5 6458.3 6552.4 6648.7 4929.1 5040.3 5068.0 5075.2 5106.5 5183.2 5189.1 5191.1 5215.8 5238.5 4639.4 5141.6 5364.9 5456.8 5566.5 5134.5 5494.3 6042.5 6240.7 6286.6 1724.7 1764.2 1775.6 1795.0 1795.1 1155.7 1273.9 1275.2 1303.2 1326.5 5858.7 5860.0 5866.5 5871.5 5894.2 5528.4 5640.0 6440.5 6473.4 6473.6 5188.0 5688.5 5848.2 5879.4 5885.3 3220.4 3330.7 3369.9 3384.4 3391.9 6428.7 6560.5 6666.7 6667.4 6676.7 6589.5 6617.9 6620.1 6643.9 6667.3 5841.9 6097.9 6165.8 6350.7 6643.6 6003.2 6091.0 6378.6 6383.4 6426.7 5082.1 5323.5 6098.5 6311.9 6376.2 6122.5 6171.6 6473.6 6615.7 6690.7 4461.5 5029.7 5035.6 5082.1 5106.4 6256.5 6388.3 6393.8 6420.6 6439.9 5289.8 6192.4 6210.7 6211.7 6220.9 4638.7 4899.2 5449.8 5521.3 5883.5 4883.7 5802.0 6052.7 6083.5 6087.4 6222.8 6225.3 6245.3 6247.3 6255.6 5311.9 5742.3 5988.9 6042.6 6135.1 09:56:59 INFO - PID 2324 | 09:56:59 INFO - PID 2324 | [#5] yui.html Cycles:180 Average:19342.89 Median:4265.87 stddev:27495.02 (644.5%) stddev-sans-first:27536.56 09:56:59 INFO - PID 2324 | Values: 711.0 715.7 727.0 761.8 803.4 14790.3 15459.9 15497.9 15619.3 15813.9 13975.6 14325.5 14595.9 14637.6 14923.8 920.6 946.7 948.3 950.9 951.1 931.0 947.9 969.8 974.1 974.9 1002.3 1020.7 1023.2 1024.0 1026.7 1012.2 1017.1 1019.4 1019.4 1022.4 760.9 763.4 763.6 763.9 764.9 15528.8 15561.1 15867.4 16135.4 16188.2 14376.4 14586.8 14600.9 14711.0 14762.3 11413.5 11520.9 11712.8 11729.7 12060.4 3580.6 3644.4 3854.5 3859.9 3870.3 99742.5 102762.0 102998.0 104917.7 105209.9 10728.7 10909.9 11283.9 11417.3 11559.7 24339.0 24549.1 24837.3 24878.5 24891.9 7456.6 7661.3 7765.8 7796.0 7946.2 4204.8 4234.8 4257.5 4361.7 4389.8 3377.9 3493.7 3495.7 3496.1 3497.9 621.3 626.4 645.3 645.5 648.3 656.4 682.8 692.9 704.9 708.2 8132.5 9405.5 9499.4 9965.2 10157.0 629.8 642.1 659.9 695.6 695.9 4274.2 4458.0 4502.5 4712.5 4726.7 87816.0 95685.5 96385.0 97734.0 100694.5 60475.0 81100.2 81220.0 85098.0 85481.6 71012.0 71713.0 74030.3 74511.6 75101.0 9172.9 9211.5 9260.0 9273.4 9296.3 36513.1 44978.3 47238.4 47796.0 48049.0 63245.4 63249.4 63308.4 63551.0 64584.7 11515.1 11633.9 11666.8 11707.2 11737.8 12531.9 12646.7 12749.6 12849.4 12940.5 11607.5 12203.3 12204.0 12214.3 12389.0 11170.3 11538.9 11659.5 11866.6 12039.6 11189.3 11468.9 11883.9 11934.9 11943.0 9674.7 9733.4 9765.4 9794.5 10051.3 9244.8 9656.9 9659.8 9680.0 9688.8 09:56:59 INFO - PID 2324 | -------- Summary: end -------- 09:56:59 INFO - PID 2324 | 09:57:00 INFO - TEST-INFO | 2324: exit 0 09:57:00 INFO - TEST-OK | dromaeo_css | took 1120119ms 09:57:00 INFO - TEST-START | kraken 09:57:00 INFO - operating with platform_type : mac_ 09:57:00 INFO - Initialising browser for kraken test... 09:57:00 INFO - TEST-INFO | started process 2326 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpKUclhC/profile http://localhost:60218/getInfo.html) 09:57:02 INFO - PID 2326 | __metrics Screen width/height:1600/1200 09:57:02 INFO - PID 2326 | colorDepth:24 09:57:02 INFO - PID 2326 | Browser inner width/height: 1024/689 09:57:02 INFO - PID 2326 | __metrics 09:57:02 INFO - PID 2326 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:57:02 INFO - PID 2326 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:57:03 INFO - TEST-INFO | 2326: exit 0 09:57:03 INFO - Browser initialized. 09:57:03 INFO - Running cycle 1/1 for kraken test... 09:57:03 INFO - TEST-INFO | started process 2327 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpKUclhC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:15 INFO - PID 2327 | RSS: Main: 233730048 09:57:15 INFO - PID 2327 | 09:57:18 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60218/tests/kraken/driver.html?testName=audio-beat-detection) 09:57:19 INFO - PID 2327 | RSS: Main: 284659712 09:57:19 INFO - PID 2327 | 09:57:22 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60218/tests/kraken/driver.html?testName=audio-dft) 09:57:22 INFO - PID 2327 | RSS: Main: 285835264 09:57:22 INFO - PID 2327 | 09:57:26 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60218/tests/kraken/driver.html?testName=audio-fft) 09:57:26 INFO - PID 2327 | RSS: Main: 376864768 09:57:26 INFO - PID 2327 | 09:57:29 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60218/tests/kraken/driver.html?testName=audio-oscillator) 09:57:29 INFO - PID 2327 | RSS: Main: 282640384 09:57:29 INFO - PID 2327 | 09:57:31 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:57:32 INFO - PID 2327 | RSS: Main: 285011968 09:57:32 INFO - PID 2327 | 09:57:35 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60218/tests/kraken/driver.html?testName=imaging-darkroom) 09:57:36 INFO - PID 2327 | RSS: Main: 325234688 09:57:36 INFO - PID 2327 | 09:57:39 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60218/tests/kraken/driver.html?testName=imaging-desaturate) 09:57:39 INFO - PID 2327 | RSS: Main: 342392832 09:57:39 INFO - PID 2327 | 09:57:42 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60218/tests/kraken/driver.html?testName=json-parse-financial) 09:57:43 INFO - PID 2327 | RSS: Main: 354394112 09:57:43 INFO - PID 2327 | 09:57:44 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:57:45 INFO - PID 2327 | RSS: Main: 302661632 09:57:45 INFO - PID 2327 | 09:57:47 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60218/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:57:48 INFO - PID 2327 | RSS: Main: 306671616 09:57:48 INFO - PID 2327 | 09:57:50 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:57:50 INFO - PID 2327 | RSS: Main: 310177792 09:57:50 INFO - PID 2327 | 09:57:53 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:57:54 INFO - PID 2327 | RSS: Main: 326471680 09:57:54 INFO - PID 2327 | 09:57:57 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:57:58 INFO - PID 2327 | RSS: Main: 320864256 09:57:58 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | Cycle 1(1): loaded http://localhost:60218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60218/tests/kraken/driver.html?testName=ai-astar) 09:58:00 INFO - PID 2327 | RSS: Main: 382427136 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | __start_tp_report 09:58:00 INFO - PID 2327 | _x_x_mozilla_page_load 09:58:00 INFO - PID 2327 | _x_x_mozilla_page_load_details 09:58:00 INFO - PID 2327 | |i|pagename|runs| 09:58:00 INFO - PID 2327 | |0;ai-astar;115;117;116;116;111;169;171;116;115;115 09:58:00 INFO - PID 2327 | |1;audio-beat-detection;134;109;111;152;110;112;135;140;149;112 09:58:00 INFO - PID 2327 | |2;audio-dft;188;184;186;190;186;186;195;263;190;186 09:58:00 INFO - PID 2327 | |3;audio-fft;81;55;75;119;82;59;60;60;81;60 09:58:00 INFO - PID 2327 | |4;audio-oscillator;90;71;90;70;66;96;118;102;72;85 09:58:00 INFO - PID 2327 | |5;imaging-gaussian-blur;87;88;92;132;88;88;87;88;88;87 09:58:00 INFO - PID 2327 | |6;imaging-darkroom;96;99;95;95;95;95;96;95;95;95 09:58:00 INFO - PID 2327 | |7;imaging-desaturate;83;86;84;84;86;87;84;85;86;84 09:58:00 INFO - PID 2327 | |8;json-parse-financial;59;60;60;61;62;61;62;62;62;63 09:58:00 INFO - PID 2327 | |9;json-stringify-tinderbox;55;55;62;69;92;86;60;61;60;61 09:58:00 INFO - PID 2327 | |10;stanford-crypto-aes;82;82;83;84;82;83;81;82;82;81 09:58:00 INFO - PID 2327 | |11;stanford-crypto-ccm;138;141;138;138;136;134;139;142;185;155 09:58:00 INFO - PID 2327 | |12;stanford-crypto-pbkdf2;187;199;236;224;186;184;181;189;184;185 09:58:00 INFO - PID 2327 | |13;stanford-crypto-sha256-iterative;69;82;93;66;57;90;95;91;82;67 09:58:00 INFO - PID 2327 | __end_tp_report 09:58:00 INFO - PID 2327 | __start_cc_report 09:58:00 INFO - PID 2327 | _x_x_mozilla_cycle_collect,2128 09:58:00 INFO - PID 2327 | __end_cc_report 09:58:00 INFO - PID 2327 | __startTimestamp1489856280535__endTimestamp 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | ------- Summary: start ------- 09:58:00 INFO - PID 2327 | Number of tests: 14 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#0] ai-astar Cycles:10 Average:126.10 Median:116.00 stddev:23.20 (20.0%) stddev-sans-first:24.25 09:58:00 INFO - PID 2327 | Values: 115.0 117.0 116.0 116.0 111.0 169.0 171.0 116.0 115.0 115.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#1] audio-beat-detection Cycles:10 Average:126.40 Median:134.50 stddev:17.34 (12.9%) stddev-sans-first:18.17 09:58:00 INFO - PID 2327 | Values: 134.0 109.0 111.0 152.0 110.0 112.0 135.0 140.0 149.0 112.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#2] audio-dft Cycles:10 Average:195.40 Median:189.00 stddev:23.96 (12.7%) stddev-sans-first:25.26 09:58:00 INFO - PID 2327 | Values: 188.0 184.0 186.0 190.0 186.0 186.0 195.0 263.0 190.0 186.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#3] audio-fft Cycles:10 Average:73.20 Median:67.50 stddev:19.31 (28.6%) stddev-sans-first:20.27 09:58:00 INFO - PID 2327 | Values: 81.0 55.0 75.0 119.0 82.0 59.0 60.0 60.0 81.0 60.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#4] audio-oscillator Cycles:10 Average:86.00 Median:78.50 stddev:16.63 (21.2%) stddev-sans-first:17.58 09:58:00 INFO - PID 2327 | Values: 90.0 71.0 90.0 70.0 66.0 96.0 118.0 102.0 72.0 85.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:88.00 stddev:13.95 (15.9%) stddev-sans-first:14.66 09:58:00 INFO - PID 2327 | Values: 87.0 88.0 92.0 132.0 88.0 88.0 87.0 88.0 88.0 87.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:1.33 09:58:00 INFO - PID 2327 | Values: 96.0 99.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.50 stddev:1.29 (1.5%) stddev-sans-first:1.17 09:58:00 INFO - PID 2327 | Values: 83.0 86.0 84.0 84.0 86.0 87.0 84.0 85.0 86.0 84.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:62.00 stddev:1.23 (2.0%) stddev-sans-first:1.01 09:58:00 INFO - PID 2327 | Values: 59.0 60.0 60.0 61.0 62.0 61.0 62.0 62.0 62.0 63.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:61.50 stddev:12.76 (20.7%) stddev-sans-first:12.88 09:58:00 INFO - PID 2327 | Values: 55.0 55.0 62.0 69.0 92.0 86.0 60.0 61.0 60.0 61.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 09:58:00 INFO - PID 2327 | Values: 82.0 82.0 83.0 84.0 82.0 83.0 81.0 82.0 82.0 81.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:140.00 stddev:15.31 (10.9%) stddev-sans-first:16.05 09:58:00 INFO - PID 2327 | Values: 138.0 141.0 138.0 138.0 136.0 134.0 139.0 142.0 185.0 155.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.50 Median:188.00 stddev:19.02 (10.1%) stddev-sans-first:19.92 09:58:00 INFO - PID 2327 | Values: 187.0 199.0 236.0 224.0 186.0 184.0 181.0 189.0 184.0 185.0 09:58:00 INFO - PID 2327 | 09:58:00 INFO - PID 2327 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.20 Median:86.00 stddev:13.46 (15.7%) stddev-sans-first:13.77 09:58:00 INFO - PID 2327 | Values: 69.0 82.0 93.0 66.0 57.0 90.0 95.0 91.0 82.0 67.0 09:58:00 INFO - PID 2327 | -------- Summary: end -------- 09:58:00 INFO - PID 2327 | 09:58:01 INFO - TEST-INFO | 2327: exit 0 09:58:01 INFO - TEST-OK | kraken | took 61212ms 09:58:01 INFO - SUITE-END | took 1181s 09:58:01 INFO - Completed test suite (00:19:41) 09:58:01 INFO - javascript benchmark 09:58:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7706.350803301592, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2930.6629737580174, 3326.0520751585805, 3344.916377090571, 3360.983195084025, 3389.0, 5677.403872593381, 5786.1610066540325, 5926.407359264077, 5941.0494320908665, 5988.0718488634275, 5847.181394604759, 5886.264216972889, 5888.470037696607, 5958.165856780043, 5998.340182579924, 4992.750362481879, 5169.974150129244, 5239.869003274911, 5290.338707661543, 5291.968066227088, 5353.250544923714, 5383.865403364908, 5393.029254734146, 5422.674639521621, 5434.619576629638, 5209.2446595243855, 5263.184206447969, 5267.815626453094, 5277.419483856773, 5345.1982202669715, 5253.9474605253845, 5254.054270231357, 5260.8684782880355, 5270.604704647167, 5287.339082614673, 5178.352705911761, 5201.661891977047, 5228.947710522884, 5233.398159211663, 5263.631545791796, 5754.4533269339345, 5769.278840144982, 5775.451332123442, 5792.565557583198, 5802.390748971382, 6254.46837018854, 6305.211848518935, 6312.747490100391, 6322.336154703782, 6332.683365831736, 6134.816205099513, 6188.566800323979, 6265.8120256392385, 6297.4962003039645, 6305.243370795534, 6014.78948236814, 6021.187139736124, 6035.124906888476, 6039.335673075958, 6072.301685306158, 5864.736086876101, 6354.523410744213, 6383.329750376237, 6388.904166437507, 6407.871842563122, 5731.398203188689, 6205.100260462298, 6205.906911396332, 6266.624002559861, 6295.150154729053, 6253.280872699606, 6260.530460215502, 6270.372962703785, 6273.62358258506, 6286.591371560926, 6225.750969961151, 6242.313345531988, 6248.343923887926, 6259.0, 6287.371262873676, 6104.0347610180015, 6179.258488981351, 6216.875662486725, 6244.094606282064, 6261.686915654199, 5115.411727651293, 5117.181250999822, 5137.717425541557, 5138.30632864566, 5153.1497302945345, 4519.954800452019, 4523.411956445641, 4544.931826022612, 4560.5895469407915, 4586.6789324747615, 5663.518600918968, 5743.54051675865, 5895.056790913433, 5944.524438044946, 5959.67221802805, 6238.781642642576, 6257.342978987232, 6262.812115636447, 6273.435390814849, 6284.717187726564, 5885.323187833454, 5899.144624029492, 5905.143754155623, 5906.8818623627285, 5907.084401917709, 5539.307586551681, 5542.39033706292, 5560.110382338807, 5569.220309156722, 5574.498295153375, 6140.320203811546, 6236.314005459487, 6260.248770147611, 6264.248290205204, 6268.341824108403, 6217.036359364306, 6240.7503699851495, 6249.750009999549, 6250.843728906631, 6278.591891527036, 6352.460040896575, 6360.968195158995, 6377.1390862233, 6390.5526613136635, 6402.295747467868, 6262.373762623702, 6267.435930766253, 6286.371362863677, 6288.025356069817, 6293.181886354744, 5245.790168393374, 6153.077038444269, 6177.876442471215, 6249.312575616769, 6278.748850045947, 6158.784442544668, 6226.315105338319, 6247.031710084944, 6255.061740738925, 6267.874642507216, 6199.039148931743, 6219.968900155471, 6243.282022567281, 6248.656323902229, 6258.186435763321, 5950.761969521343, 6004.759809607567, 6116.66358350295, 6124.724387402489, 6127.417895299939, 6157.907631385622, 6215.751369945152, 6267.2479302484, 6269.843253918689, 6278.560500765086, 6077.756889724538, 6116.17431646722, 6116.5106791457465, 6137.631742095488, 6152.292486363946], "value": 5781.354577296931, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.2356055724554, 788.8461749958758, 846.7883029242689, 860.7675927499575, 863.9265662418694, 36104.91685249443, 36506.817465912696, 36538.0, 36558.0, 36562.45156322654, 37315.62684373155, 37562.8121859391, 37675.999999999935, 37687.81156094216, 37809.0547736306, 7147.106611673541, 7842.647080881374, 9182.0, 9203.309751768611, 9220.953895230514, 7202.747903823367, 7307.415406767473, 7314.378277846389, 7318.3047610476915, 7320.341169294762, 10577.259591828575, 10785.46072696362, 10802.51388687511, 10805.83791243132, 10816.0, 10791.62229321974, 10837.18721095921, 10887.945560272188, 10892.40091794951, 10910.836337454944, 7088.503804733671, 7215.567065976058, 10512.316699414514, 10607.628732994386, 10633.78732425355, 35882.82058589716, 36065.918022459366, 36084.63915360865, 36112.819435902915, 36232.9273901654, 3315.5689760331, 3722.8696995605296, 3761.9435708464393, 3778.3010143123333, 3794.7912864792424, 26004.829782659825, 26510.728995364545, 26538.20385388422, 27334.863325683444, 27562.621868906474, 3086.382723455318, 3117.8441077946013, 3207.2142325130494, 3215.4855223164413, 3242.205659613386, 304266.4786676075, 304854.0, 304901.0, 305217.0, 305692.0, 37437.81281093577, 38478.03804904844, 50594.49405505972, 50702.6340653788, 50825.491745082814, 40505.55702765239, 40578.98552536151, 40715.77852664425, 40730.592694073275, 40734.0, 13817.0, 13860.653483662989, 13864.792028119586, 13895.930520347334, 13897.86102138986, 11428.657140285804, 11453.656390308304, 11476.942615287036, 11477.770444591062, 11483.598074067535, 12194.207376520499, 12231.510739570496, 12328.630141095782, 12341.50633974631, 12367.69080772988, 4966.478519755374, 5473.589480788957, 5615.157726341082, 5615.971920140455, 5642.379338272786, 1031.9380837149795, 1041.2151828104893, 1054.5623566219933, 1055.7518983038979, 1084.6312253833735, 26558.203253902415, 26581.734182658314, 26811.329716756845, 27154.86422567914, 27290.5906411404, 1031.28841099641, 1038.6520515627199, 1110.5502271580024, 1152.9884701153048, 1164.7670465906851, 13176.47294108244, 13635.977301702413, 13930.233837139054, 14005.929970350084, 14017.0, 429907.0, 430146.0, 430180.0, 430574.0, 430589.0, 54210.72894635502, 54228.72885635547, 54274.0, 54306.0, 54397.72801136048, 1346.8181795457488, 1435.8564143585559, 1439.2084353605685, 1441.7981482592445, 1444.4366696988184, 24220.75779242185, 25028.24915252545, 26002.21993340203, 26074.478510430064, 26143.477130457664, 43728.781356093015, 43869.561304386545, 43915.90210244642, 44026.11947760963, 44104.33843492286, 391467.0, 391598.0, 393569.0, 394278.0, 394440.5837387033, 31849.522257166624, 32458.86393976294, 32475.512867306537, 32483.512747309283, 32654.34691306113, 30562.694373055983, 33437.498437523944, 38165.61834381732, 38609.613903860605, 42455.93860153521, 30473.61975456767, 32944.67055329512, 33011.66988330182, 34716.0, 35327.11682207965, 33500.664993349754, 33505.83247083749, 33957.830210848784, 34833.0, 34962.47556286607, 25235.621465678396, 34944.65055349414, 34979.47530786989, 35020.82489587638, 35119.824400877835, 23824.642630360213, 26255.343616409744, 29943.85028074846, 30040.399192016474, 30070.0, 20445.661844827555, 21955.560888782453, 23104.768952310933, 23400.414989625395, 23523.764762352843], "value": 17736.49828201282, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.8182990334737, 396.18979187561416, 413.673198173443, 414.2419372548237, 432.27809558038075, 18801.0, 19856.90071549642, 20878.582428351423, 21077.946102694863, 21206.469838254034, 21920.23279185229, 22232.333030009086, 22438.775612243873, 23299.883500582517, 23545.882270588623, 6462.483001359892, 6876.1748590169245, 6881.41507971823, 6894.207166175879, 6900.5859648421, 6167.938320616804, 6608.173978252718, 6687.531872768908, 6759.966200168992, 6764.222114456827, 6417.967910160442, 6743.932560674404, 6750.021246919194, 6753.3921947024755, 6774.695138718769, 6584.703688334012, 6738.258791532977, 6747.595144291309, 6749.088873002155, 6757.121574195372, 6293.685315734195, 6365.236171659384, 6507.219133703986, 6520.054592084169, 6520.250171230322, 26790.73209267902, 26919.461610767674, 26927.0, 27051.59422608643, 27247.318817029536, 3276.3611095836322, 3381.6449272826244, 3391.0844072100394, 3449.2066824630474, 3487.093355727504, 16523.091229982347, 17236.82763172365, 17248.39630612935, 17277.30890764368, 17278.91360543202, 1897.73431719558, 1992.402279316214, 1993.5713821528295, 1994.4814348269554, 2063.9793602063937, 143449.8482522763, 148445.0, 154050.0, 154314.0, 154512.99999999886, 18583.106267029973, 20662.380128596167, 20729.0, 20901.79098209029, 21058.2629607963, 33948.32103357919, 33979.49030764541, 34070.65929340725, 34133.0, 34293.314133717686, 8100.311473524816, 8686.826263474695, 9936.80126397468, 10123.341982771097, 10145.34055286404, 8335.416520843482, 8354.916450835413, 8362.24739773411, 8527.573621318908, 8594.441361311494, 7956.840863182704, 9501.714948551555, 9699.903000970042, 9860.359076659994, 9888.116570640457, 3510.5962814276686, 3543.875964341236, 4080.8571699990357, 4092.6112019358116, 4100.17996400721, 800.9199080091944, 891.0955380289012, 910.9544522773834, 922.4880191493785, 947.4646824544111, 22212.444688882908, 22803.543929121326, 22969.655455168187, 23202.0, 23784.04863805463, 762.4205603741196, 837.0744248850186, 889.8709687095464, 932.5523748600709, 951.8143961927497, 9991.734138010117, 11279.774404511863, 11811.704707382385, 12021.939890300668, 12068.396580170956, 659512.0, 660394.0, 672457.0, 691343.0, 691945.2651998053, 129457.0, 134241.0, 144484.0, 148578.0, 149057.0, 1207.221342234254, 1223.932683702387, 1247.4947646203302, 1252.1360261419773, 1257.1074537078593, 19059.475241980886, 19807.910564918493, 19852.404427867186, 19898.104585293408, 19915.60168796645, 43298.0, 45355.54644453645, 58611.12083318668, 63114.73770524472, 63744.0, 86528.8257778318, 87835.56082219804, 88347.0, 89316.0, 90344.54827725819, 10854.240203186017, 11022.44887755593, 11396.316221026766, 11595.652130436101, 12101.75796484083, 13562.457501699822, 13603.455861765418, 13752.174869507862, 14139.717205655623, 14149.717005659622, 11611.477483513094, 11687.298762074302, 11697.473613687574, 11938.343391113573, 11993.880061199276, 11487.885121148682, 11503.76992460163, 11617.767644647229, 11635.41822908868, 11829.76340473203, 11373.090152787592, 11764.941175294069, 11877.76244475123, 12067.336296503776, 12091.39543022863, 11686.94156529212, 11688.590899318484, 11971.0247809114, 11985.580504682293, 12059.939700301442, 9462.716118516455, 11586.131040171853, 11916.880831191576, 11956.940215298868, 11968.042556595625], "value": 11559.349213516605, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.592422273319, 1561.375449820072, 1579.2735341742798, 1600.5358446050645, 1656.7680524726536, 9001.819963600732, 9419.48192849393, 10733.83899241512, 10891.782164356708, 10901.400422976732, 10626.990435908576, 10716.35701857887, 10727.302725322848, 10728.249022568423, 10745.946270268658, 2308.4228942764353, 2357.669926210332, 2359.0210062823908, 2361.3624321433203, 2370.502194539149, 1956.9510762230916, 2037.0120491561581, 2042.3770749921343, 2042.4995876010398, 2328.359701082199, 2007.217185297735, 2016.4555569996091, 2278.4303924018996, 2344.4842134730334, 2360.5042940982416, 2321.1643808229023, 2324.755900630443, 2328.452813588822, 2329.650552417134, 2331.6385960176117, 2222.811061059812, 2309.030207312933, 2312.09828167015, 2320.582295186866, 2321.1063740459876, 10881.891181088167, 11004.724881877937, 11013.669589912315, 11024.724381890437, 11077.224594278403, 5417.891642167174, 5625.8593535161535, 5628.859278518029, 5646.661200327952, 5656.349519805234, 2966.9274571501896, 3381.2730262993327, 3454.896353109411, 3506.544149260605, 3606.675399214057, 1171.08070164921, 1175.6061719324036, 1220.2373516552154, 1234.456838990841, 1235.8146278058273, 14951.626209344744, 15043.924780376137, 15099.622509437242, 15109.924450377897, 15174.772378414333, 4707.964247865532, 4721.834735784231, 4810.879728006757, 4848.8302909398, 4927.679700819435, 12494.0, 12497.50009999608, 12502.062345324137, 12508.812367814307, 12521.749565008831, 5882.588218824641, 5889.764409423661, 5899.056151015902, 5900.586958912921, 5904.232449781501, 5075.695458272442, 5157.149070403417, 5161.922571161435, 5215.817446389358, 5216.869578260574, 3573.1960308930284, 3834.539855217392, 3923.685025834714, 4003.559608443069, 4013.9328245953357, 980.5734505490135, 1039.2050081687514, 1053.4153544782719, 1089.5206109311878, 1144.9656510304703, 928.7538802217417, 943.613118621362, 950.2825366847985, 953.8378475659155, 975.3224453939213, 6110.816675499653, 6270.435660790551, 6466.902996455057, 6608.537402381787, 6713.0937323461685, 1010.9090181883665, 1012.4532752313668, 1013.6300250408548, 1028.99485502572, 1029.4235228272191, 4241.045764702917, 4265.338872474771, 4285.442892423965, 4401.537838526972, 4422.889427764331, 13220.140690855063, 13677.31613419325, 13680.726385472235, 13688.452461901412, 13693.589192324247, 12806.871931280568, 13211.0, 13500.392482338319, 13572.728545429036, 13683.86316136826, 9816.838126393082, 9821.656242031495, 9853.408795472295, 9929.0, 9990.15083717892, 6273.96863015682, 6361.777337793155, 6468.417842394207, 6714.6978385973725, 6774.187097548326, 11796.882031179579, 12169.513219471122, 12230.388480575757, 12235.877641223475, 12309.076819238771, 12156.452959616661, 12335.074869384653, 12521.56174533887, 12666.746665066463, 12828.358582071045, 8233.135520770473, 8405.411621186458, 8418.6211620476, 8419.747407577783, 8428.704995325133, 9875.061869122423, 9930.702078937644, 10029.849552256575, 10030.799384012133, 10100.838403583683, 8428.873566896624, 8572.014218364719, 8601.870971935552, 8767.254783343487, 8821.294296456397, 8485.703000394957, 8485.91514084876, 8574.442661227, 8621.87067194005, 8634.481931084156, 7648.885266721115, 7801.258880406353, 7820.84358312842, 7830.3735701144915, 7833.686652533835, 5697.287839020122, 5716.314042314949, 5838.503727183237, 5910.379410162043, 5954.583179177589, 5697.943020569741, 5726.2269593606, 5945.197398351167, 6025.915335239523, 6056.364081771527], "value": 5058.0479075175335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.27426244560667, 370.4517314374725, 386.1003861003861, 386.9071422858513, 387.4517557655917, 4890.975545122269, 5856.590038697287, 5895.941040589592, 5910.88178236435, 5922.230110085683, 5449.373322067963, 5726.455986681269, 5771.0, 5820.476157145856, 5825.1844741736195, 4072.735272207312, 4769.499202583731, 4774.379330687015, 4784.234522476387, 4785.306130611059, 3879.689624830007, 3920.1963597462595, 4827.203511420611, 4827.541383568555, 4869.0, 4653.557911998355, 4704.858854234379, 4742.383490146276, 4764.928526072112, 4818.59041981432, 3567.9643203567894, 4146.419501269825, 4725.243960966229, 4749.670092374124, 4752.289175896674, 3658.9634103659155, 4354.56144559048, 4367.71609845359, 4372.0, 4406.669499787528, 4435.667324950641, 5645.745941432604, 5651.9152212716845, 5729.369769325371, 5766.079066234958, 5518.33779946405, 5525.817302165662, 5536.972315138439, 5538.667679939216, 5550.91673624896, 5215.24378965048, 5949.553783466257, 6224.62652240867, 6263.906041409337, 6272.968635156795, 4827.758612069382, 4889.975550122263, 4925.3350797642215, 4931.791711030821, 4934.136526107953, 6244.625322480666, 6445.548811583144, 6458.289588145253, 6552.410283074546, 6648.66756662165, 4929.137400954819, 5040.344755181803, 5068.0, 5075.238714192827, 5106.54463477907, 5183.196604526304, 5189.065968125774, 5191.143461328838, 5215.791368345223, 5238.537887193013, 4639.350490931272, 5141.5886729061585, 5364.91952620711, 5456.772226249062, 5566.471185237396, 5134.510991812407, 5494.2582751328855, 6042.516598672096, 6240.687965601702, 6286.622802631857, 1724.7499112628598, 1764.1884733022696, 1775.6448710258, 1794.9820501795075, 1795.1293622593032, 1155.664857191405, 1273.8789814967563, 1275.1775105057186, 1303.2180691584974, 1326.476041963419, 5858.740370820294, 5860.0, 5866.501347385435, 5871.500922421642, 5894.204282421818, 5528.391876893538, 5640.0, 6440.488209598167, 6473.352664733583, 6473.643949582818, 5187.974060129675, 5688.459596338424, 5848.210491583582, 5879.441453061952, 5885.264341957255, 3220.388126256004, 3330.733541316689, 3369.882054128143, 3384.3569721752788, 3391.9152021199666, 6428.742850285937, 6560.507961902781, 6666.699998500079, 6667.399934005963, 6676.732930682815, 6589.472842172615, 6617.86383510306, 6620.139381880324, 6643.900341494881, 6667.266600673922, 5841.88316233673, 6097.932861749265, 6165.84585385369, 6350.650714210763, 6643.60138391698, 6003.219581454383, 6090.969545152423, 6378.617282963037, 6383.446621351496, 6426.710798014195, 5082.059818933509, 5323.494268044529, 6098.481629061579, 6311.936880631135, 6376.202974628171, 6122.5408094392205, 6171.59884607499, 6473.643949582818, 6615.702293396905, 6690.732370705117, 4461.486929003207, 5029.748512574283, 5035.647504674637, 5082.136036873814, 5106.361704786902, 6256.530760192913, 6388.329225431263, 6393.808185754248, 6420.646864422315, 6439.935600644121, 5289.788408463773, 6192.411720886508, 6210.720517576629, 6211.689005899891, 6220.906686399617, 4638.744869032235, 4899.216125419915, 5449.782008719607, 5521.282233309644, 5883.499902508334, 4883.682560633548, 5802.0, 6052.667103309184, 6083.482903953213, 6087.391260874055, 6222.844428889314, 6225.284092329259, 6245.344238854855, 6247.282432142033, 6255.624662520263, 5311.867203319948, 5742.339630942495, 5988.850278743066, 6042.637441753509, 6135.07973803933], "value": 4740.861876928198, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.9928900710992, 715.7316006497564, 726.9963650181749, 761.847630473905, 803.4215364937247, 14790.260486975649, 15459.922700386496, 15497.92251038746, 15619.297131629075, 15813.920930395361, 13975.580732578039, 14325.498607548738, 14595.92702036491, 14637.560873173796, 14923.776143357858, 920.6179435534262, 946.7254496196094, 948.3077353531926, 950.8621249918758, 951.1202138022336, 930.9813803723921, 947.8767760191165, 969.7672558585924, 974.1281553010052, 974.9415035097882, 1002.298391126211, 1020.7193021918957, 1023.2428003277558, 1023.9590416383336, 1026.7279171019686, 1012.1649639047778, 1017.099866618041, 1019.3730855523836, 1019.3934608907688, 1022.4223313827738, 760.9010828592303, 763.4198009512754, 763.6067425275987, 763.8777795552685, 764.8814433762776, 15528.844711552852, 15561.144137072457, 15867.365305387772, 16135.435259765853, 16188.190590470429, 14376.424943002268, 14586.827298077853, 14600.926995364955, 14711.0, 14762.261886905719, 11413.486393112247, 11520.884791152064, 11712.765744685059, 11729.70675733105, 12060.396980150957, 3580.5524309461316, 3644.380455322575, 3854.4603755474254, 3859.8842034739005, 3870.2646497165447, 99742.50128749383, 102762.0, 102998.0, 104917.67549681939, 105209.89580208353, 10728.731781705364, 10909.890901091047, 11283.887161128448, 11417.257878237888, 11559.653210403701, 24339.0, 24549.140780072612, 24837.254882353558, 24878.5024299513, 24891.875540622183, 7456.552606843607, 7661.31048205653, 7765.7670269892, 7796.0, 7946.218823411759, 4204.810783514749, 4234.767087810138, 4257.5233845019975, 4361.738295702268, 4389.780510974439, 3377.8986630401128, 3493.703035242033, 3495.685388315064, 3496.0910163357203, 3497.8600855965983, 621.254494606474, 626.3517259636254, 645.270843946347, 645.4836131095105, 648.2609824799732, 656.3600489522772, 682.7883356159606, 692.8648913461826, 704.8766465868453, 708.1855865754321, 8132.534634965217, 9405.482698451651, 9499.430034197832, 9965.152961998167, 10157.0, 629.8456878064903, 642.1267076775581, 659.9340065993363, 695.5583204665074, 695.9025736396909, 4274.21867658475, 4457.955420445754, 4502.5047244803045, 4712.481627021025, 4726.71639701619, 87816.0, 95685.52157239309, 96385.0, 97734.0226597725, 100694.49652751836, 60475.0, 81100.18899810927, 81220.0, 85098.0, 85481.57259213664, 71012.0, 71713.0, 74030.25969740341, 74511.62744186244, 75101.0, 9172.862407063765, 9211.493367864563, 9260.0, 9273.397229180082, 9296.349255552317, 36513.087172820895, 44978.3253251195, 47238.371366442276, 47796.0, 48049.0, 63245.36754632395, 63249.36750632435, 63308.417289566285, 63551.0467342981, 64584.67707661619, 11515.136364772508, 11633.941830291133, 11666.76666466649, 11707.239029463057, 11737.823932641188, 12531.87468125307, 12646.683832904251, 12749.553765618159, 12849.421776020288, 12940.482380704667, 11607.477663505331, 12203.328816915155, 12204.0, 12214.26714397139, 12389.008879289455, 11170.329780213213, 11538.94230528842, 11659.53361865516, 11866.644000679993, 12039.63881083569, 11189.328640281608, 11468.885311147116, 11883.940580297043, 11934.880651193724, 11943.04455643529, 9674.661386851427, 9733.367331123454, 9765.41407515523, 9794.510274486105, 10051.297375367183, 9244.815103698023, 9656.9034309656, 9659.806803863743, 9679.951600241953, 9688.75778105553], "value": 7368.618873329514, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 116.0, 116.0, 111.0, 169.0, 171.0, 116.0, 115.0, 115.0], "value": 126.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 109.0, 111.0, 152.0, 110.0, 112.0, 135.0, 140.0, 149.0, 112.0], "value": 126.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 184.0, 186.0, 190.0, 186.0, 186.0, 195.0, 263.0, 190.0, 186.0], "value": 195.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 55.0, 75.0, 119.0, 82.0, 59.0, 60.0, 60.0, 81.0, 60.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 90.0, 70.0, 66.0, 96.0, 118.0, 102.0, 72.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 92.0, 132.0, 88.0, 88.0, 87.0, 88.0, 88.0, 87.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 84.0, 84.0, 86.0, 87.0, 84.0, 85.0, 86.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 63.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 62.0, 69.0, 92.0, 86.0, 60.0, 61.0, 60.0, 61.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 84.0, 82.0, 83.0, 81.0, 82.0, 82.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 138.0, 138.0, 136.0, 134.0, 139.0, 142.0, 185.0, 155.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 199.0, 236.0, 224.0, 186.0, 184.0, 181.0, 189.0, 184.0, 185.0], "value": 195.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 93.0, 66.0, 57.0, 90.0, 95.0, 91.0, 82.0, 67.0], "value": 79.2, "unit": "score"}]}]} 09:58:01 INFO - Return code: 0 09:58:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:58:01 ERROR - # TBPL SUCCESS # 09:58:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:58:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:58:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:58:01 INFO - 2017-03-18 09:58:01.865 screenresolution[2331:80516] starting screenresolution argv=screenresolution get 09:58:01 INFO - 2017-03-18 09:58:01.867 screenresolution[2331:80516] Display 0: 1600x1200x32@60 09:58:01 INFO - 2017-03-18 09:58:01.874 screenresolution[2332:80519] starting screenresolution argv=screenresolution list 09:58:01 INFO - Available Modes on Display 0 09:58:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:58:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:58:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:58:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:58:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:58:02 INFO - Intel Iris: 09:58:02 INFO - Chipset Model: Intel Iris 09:58:02 INFO - Type: GPU 09:58:02 INFO - Bus: Built-In 09:58:02 INFO - VRAM (Dynamic, Max): 1536 MB 09:58:02 INFO - Vendor: Intel (0x8086) 09:58:02 INFO - Device ID: 0x0a2e 09:58:02 INFO - Revision ID: 0x0009 09:58:02 INFO - Displays: 09:58:02 INFO - Display: 09:58:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:58:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:58:02 INFO - Display Serial Number: 1600x1200 60 09:58:02 INFO - Main Display: Yes 09:58:02 INFO - Mirror: Off 09:58:02 INFO - Online: Yes 09:58:02 INFO - Rotation: Supported 09:58:02 INFO - Return code: 0 09:58:02 INFO - Running post-action listener: _resource_record_post_action 09:58:02 INFO - [mozharness: 2017-03-18 16:58:02.122046Z] Finished run-tests step (success) 09:58:02 INFO - Running post-run listener: _resource_record_post_run 09:58:02 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 2781184; Write bytes: 514211328; Read time: 11; Write time: 1737 09:58:02 INFO - TinderboxPrint: CPU usage
53.6% 09:58:02 INFO - TinderboxPrint: I/O read bytes / time
2,781,184 / 11 09:58:02 INFO - TinderboxPrint: I/O write bytes / time
514,211,328 / 1,737 09:58:02 INFO - TinderboxPrint: CPU idle
2,229.9 (46.4%) 09:58:02 INFO - TinderboxPrint: CPU system
962.1 (20.0%) 09:58:02 INFO - TinderboxPrint: CPU user
1,617.6 (33.6%) 09:58:02 INFO - TinderboxPrint: Swap in / out
212,459,520 / 0 09:58:02 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203514368; Write bytes: 201306112; Read time: 15589; Write time: 474 09:58:02 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 2781184; Write bytes: 302095872; Read time: 11; Write time: 1229 09:58:02 INFO - Running post-run listener: _upload_blobber_files 09:58:02 INFO - Blob upload gear active. 09:58:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:58:02 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 09:58:02 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'] 09:58:02 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 09:58:03 INFO - (blobuploader) - INFO - Open directory for files ... 09:58:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:58:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:58:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:03 INFO - (blobuploader) - INFO - Done attempting. 09:58:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:58:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:58:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:04 INFO - (blobuploader) - INFO - Done attempting. 09:58:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:58:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:58:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:05 INFO - (blobuploader) - INFO - Done attempting. 09:58:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:58:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:58:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:07 INFO - (blobuploader) - INFO - Done attempting. 09:58:07 INFO - (blobuploader) - INFO - Iteration through files over. 09:58:07 INFO - Return code: 0 09:58:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:58:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:58:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1184de7ac33e4f2ccaa60d5ff07a07ef2433c2e73b7811b04a9ee43b96165d8baa66f3c88beddf226b0085c0161b67e407044afbcb9af4568234f4702609d0e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acb3a2a992d9bcb74b015cd6d689b413bf1b32923c315dc3855f787627522ea30772e933a441dbc7cc7dab404f25ae0111927e4add56b47085e36ab24399dd2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a029d17396781f5c3b666e20cf8216cff3e068bd54025ca5c40b014cc19687e2d5db18bf89cb56fad57ab76abc353ee6009a981aeb9e0dc892481bf966bcd3ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a873f565b0649738e458748a4bb5a6a34f35c86a0ec11bad44bb3066f0ec50d4d1f9a0d41afe5ff575ff2fba8da50fd3720ce1c34088f8f0c0590242249581f"} 09:58:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:58:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:58:07 INFO - Contents: 09:58:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1184de7ac33e4f2ccaa60d5ff07a07ef2433c2e73b7811b04a9ee43b96165d8baa66f3c88beddf226b0085c0161b67e407044afbcb9af4568234f4702609d0e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acb3a2a992d9bcb74b015cd6d689b413bf1b32923c315dc3855f787627522ea30772e933a441dbc7cc7dab404f25ae0111927e4add56b47085e36ab24399dd2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a029d17396781f5c3b666e20cf8216cff3e068bd54025ca5c40b014cc19687e2d5db18bf89cb56fad57ab76abc353ee6009a981aeb9e0dc892481bf966bcd3ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a873f565b0649738e458748a4bb5a6a34f35c86a0ec11bad44bb3066f0ec50d4d1f9a0d41afe5ff575ff2fba8da50fd3720ce1c34088f8f0c0590242249581f"} 09:58:07 INFO - Running post-run listener: copy_logs_to_upload_dir 09:58:07 INFO - Copying logs to upload dir... 09:58:07 INFO - mkdir: /builds/slave/test/build/upload/logs 09:58:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.409645 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-18 09:58:07.542539) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-18 09:58:07.546835) ========= 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.rdCeAQQW8A/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.sEgoGEaD84/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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/1184de7ac33e4f2ccaa60d5ff07a07ef2433c2e73b7811b04a9ee43b96165d8baa66f3c88beddf226b0085c0161b67e407044afbcb9af4568234f4702609d0e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acb3a2a992d9bcb74b015cd6d689b413bf1b32923c315dc3855f787627522ea30772e933a441dbc7cc7dab404f25ae0111927e4add56b47085e36ab24399dd2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a029d17396781f5c3b666e20cf8216cff3e068bd54025ca5c40b014cc19687e2d5db18bf89cb56fad57ab76abc353ee6009a981aeb9e0dc892481bf966bcd3ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a873f565b0649738e458748a4bb5a6a34f35c86a0ec11bad44bb3066f0ec50d4d1f9a0d41afe5ff575ff2fba8da50fd3720ce1c34088f8f0c0590242249581f"} build_url:https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/NLo1kPJVQpmVr1nLGWHG2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1184de7ac33e4f2ccaa60d5ff07a07ef2433c2e73b7811b04a9ee43b96165d8baa66f3c88beddf226b0085c0161b67e407044afbcb9af4568234f4702609d0e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acb3a2a992d9bcb74b015cd6d689b413bf1b32923c315dc3855f787627522ea30772e933a441dbc7cc7dab404f25ae0111927e4add56b47085e36ab24399dd2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a029d17396781f5c3b666e20cf8216cff3e068bd54025ca5c40b014cc19687e2d5db18bf89cb56fad57ab76abc353ee6009a981aeb9e0dc892481bf966bcd3ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a873f565b0649738e458748a4bb5a6a34f35c86a0ec11bad44bb3066f0ec50d4d1f9a0d41afe5ff575ff2fba8da50fd3720ce1c34088f8f0c0590242249581f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-18 09:58:07.587576) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-18 09:58:07.587951) ========= 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.rdCeAQQW8A/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.sEgoGEaD84/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.005292 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-18 09:58:07.640356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-18 09:58:07.640743) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-18 09:58:07.641185) ========= ========= Total master_lag: 0.21 =========