builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0138 starttime: 1492284612.85 results: success (0) buildid: 20170415110113 builduid: ef2f4dcf96354aad85ace5c4be175bd3 revision: d65b53cf8fd9f7747c7ee4e3ea96f12434917daa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-15 12:30:12.852981) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-15 12:30:12.853422) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-15 12:30:12.853739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-15 12:30:12.979708) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 12:30:12.980099) ========= 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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners TMPDIR=/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-15 12:30:13-- 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% 161M=0s 2017-04-15 12:30:13 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156019 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 12:30:13.164142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 12:30:13.164788) ========= 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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners TMPDIR=/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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.028498 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 12:30:13.232378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-15 12:30:13.232753) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d65b53cf8fd9f7747c7ee4e3ea96f12434917daa --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 d65b53cf8fd9f7747c7ee4e3ea96f12434917daa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zsBm9qkEfc/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.i1eE3qZNoC/Listeners TMPDIR=/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-15 12:30:13,346 truncating revision to first 12 chars 2017-04-15 12:30:13,346 Setting DEBUG logging. 2017-04-15 12:30:13,346 attempt 1/10 2017-04-15 12:30:13,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d65b53cf8fd9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-15 12:30:14,651 unpacking tar archive at: mozilla-central-d65b53cf8fd9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.603043 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-15 12:30:14.864749) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-15 12:30:14.865603) ========= script_repo_revision: d65b53cf8fd9f7747c7ee4e3ea96f12434917daa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-15 12:30:14.866557) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-15 12:30:14.867195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-15 12:30:14.888189) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-15 12:30:14.888520) ========= /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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners TMPDIR=/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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 12:30:15 INFO - MultiFileLogger online at 20170415 12:30:15 in /builds/slave/test 12:30:15 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 12:30:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:30:15 INFO - {'append_to_log': False, 12:30:15 INFO - 'base_work_dir': '/builds/slave/test', 12:30:15 INFO - 'blob_upload_branch': 'Firefox', 12:30:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:30:15 INFO - 'branch': 'Firefox', 12:30:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:30:15 INFO - 'config_files': ('talos/mac_config.py',), 12:30:15 INFO - 'default_actions': ('clobber', 12:30:15 INFO - 'read-buildbot-config', 12:30:15 INFO - 'download-and-extract', 12:30:15 INFO - 'populate-webroot', 12:30:15 INFO - 'create-virtualenv', 12:30:15 INFO - 'install', 12:30:15 INFO - 'run-tests'), 12:30:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:30:15 INFO - 'download_minidump_stackwalk': True, 12:30:15 INFO - 'download_symbols': 'ondemand', 12:30:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:30:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:30:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:30:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:30:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:30:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:30:15 INFO - 'gecko_profile': False, 12:30:15 INFO - 'gecko_profile_interval': 0, 12:30:15 INFO - 'installer_path': 'installer.exe', 12:30:15 INFO - 'log_level': 'info', 12:30:15 INFO - 'log_name': 'talos', 12:30:15 INFO - 'log_to_console': True, 12:30:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:30:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:30:15 INFO - 'opt_config_files': (), 12:30:15 INFO - 'pip_index': False, 12:30:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:30:15 INFO - 'cmd': ('bash', 12:30:15 INFO - '-c', 12:30:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:30:15 INFO - 'enabled': True, 12:30:15 INFO - 'halt_on_failure': False, 12:30:15 INFO - 'name': 'check_screen_resolution'},), 12:30:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:30:15 INFO - 'cmd': ('bash', 12:30:15 INFO - '-c', 12:30:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:30:15 INFO - 'enabled': True, 12:30:15 INFO - 'halt_on_failure': False, 12:30:15 INFO - 'name': 'check_screen_resolution'},), 12:30:15 INFO - 'run_cmd_checks_enabled': True, 12:30:15 INFO - 'suite': 'dromaeojs', 12:30:15 INFO - 'system_bits': '32', 12:30:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:30:15 INFO - 'title': 't-yosemite-r7-0138', 12:30:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:30:15 INFO - 'use_talos_json': True, 12:30:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:30:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:30:15 INFO - 'work_dir': 'build'} 12:30:15 INFO - [mozharness: 2017-04-15 19:30:15.105307Z] Running clobber step. 12:30:15 INFO - Running pre-action listener: _resource_record_pre_action 12:30:15 INFO - Running main action method: clobber 12:30:15 INFO - rmtree: /builds/slave/test/build 12:30:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:30:17 INFO - Running post-action listener: _resource_record_post_action 12:30:17 INFO - [mozharness: 2017-04-15 19:30:17.563965Z] Finished clobber step (success) 12:30:17 INFO - [mozharness: 2017-04-15 19:30:17.564094Z] Running read-buildbot-config step. 12:30:17 INFO - Running pre-action listener: _resource_record_pre_action 12:30:17 INFO - Running main action method: read_buildbot_config 12:30:17 INFO - Using buildbot properties: 12:30:17 INFO - { 12:30:17 INFO - "project": "", 12:30:17 INFO - "product": "firefox", 12:30:17 INFO - "script_repo_revision": "production", 12:30:17 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 12:30:17 INFO - "repository": "", 12:30:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 12:30:17 INFO - "buildid": "20170415110113", 12:30:17 INFO - "pgo_build": "False", 12:30:17 INFO - "basedir": "/builds/slave/test", 12:30:17 INFO - "buildnumber": 10, 12:30:17 INFO - "slavename": "t-yosemite-r7-0138", 12:30:17 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:30:17 INFO - "platform": "yosemite_r7", 12:30:17 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:30:17 INFO - "branch": "mozilla-central", 12:30:17 INFO - "repo_path": "mozilla-central", 12:30:17 INFO - "revision": "d65b53cf8fd9f7747c7ee4e3ea96f12434917daa", 12:30:17 INFO - "stage_platform": "macosx64", 12:30:17 INFO - "builduid": "ef2f4dcf96354aad85ace5c4be175bd3", 12:30:17 INFO - "slavebuilddir": "test" 12:30:17 INFO - } 12:30:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 12:30:17 INFO - Running post-action listener: _resource_record_post_action 12:30:17 INFO - [mozharness: 2017-04-15 19:30:17.567402Z] Finished read-buildbot-config step (success) 12:30:17 INFO - [mozharness: 2017-04-15 19:30:17.567513Z] Running download-and-extract step. 12:30:17 INFO - Running pre-action listener: _resource_record_pre_action 12:30:17 INFO - Running main action method: download_and_extract 12:30:17 INFO - mkdir: /builds/slave/test/build/tests 12:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:17 INFO - trying https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 12:30:17 INFO - Downloading https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/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 12:30:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/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 12:30:18 INFO - Downloaded 1325 bytes. 12:30:18 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:30:18 INFO - Using the following test package requirements: 12:30:18 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:30:18 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 12:30:18 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:30:18 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:30:18 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 12:30:18 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:30:18 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 12:30:18 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:30:18 INFO - u'jsshell-mac.zip'], 12:30:18 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:30:18 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 12:30:18 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:30:18 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:30:18 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 12:30:18 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:30:18 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 12:30:18 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:30:18 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 12:30:18 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:30:18 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 12:30:18 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:30:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:30:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:30:18 INFO - Fetch https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:30:20 INFO - Expected file size: 52664075 12:30:20 INFO - Obtained file size: 52664075 12:30:36 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 12:30:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:30:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:30:36 INFO - Fetch https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:30:38 INFO - Expected file size: 52664075 12:30:38 INFO - Obtained file size: 52664075 12:30:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 12:30:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:30:53 INFO - Fetch https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 12:30:54 INFO - Expected file size: 14408802 12:30:54 INFO - Obtained file size: 14408802 12:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:55 INFO - trying https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:30:55 INFO - Downloading https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 12:30:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/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 12:30:57 INFO - Downloaded 71439909 bytes. 12:30:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:30:57 INFO - mkdir: /builds/slave/test/properties 12:30:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:30:57 INFO - Writing to file /builds/slave/test/properties/build_url 12:30:57 INFO - Contents: 12:30:57 INFO - build_url:https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:30:57 INFO - Running post-action listener: _resource_record_post_action 12:30:57 INFO - Running post-action listener: set_extra_try_arguments 12:30:57 INFO - [mozharness: 2017-04-15 19:30:57.879752Z] Finished download-and-extract step (success) 12:30:57 INFO - [mozharness: 2017-04-15 19:30:57.879874Z] Running populate-webroot step. 12:30:57 INFO - Running pre-action listener: _resource_record_pre_action 12:30:57 INFO - Running main action method: populate_webroot 12:30:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:30:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:30:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:30:57 INFO - '--tppagecycles', 12:30:57 INFO - '7'], 12:30:57 INFO - 'tests': ['tsvgm']}}, 12:30:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:30:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:30:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:30:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:30:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:30:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:30:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:30:57 INFO - 'talos_options': ['--disable-e10s'], 12:30:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:30:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:30:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:30:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:30:57 INFO - 'talos_options': ['--disable-e10s'], 12:30:57 INFO - 'tests': ['damp', 'tps']}, 12:30:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:30:57 INFO - 'tests': ['damp', 'tps']}, 12:30:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:30:57 INFO - 'tests': ['dromaeo_dom']}, 12:30:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:30:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:30:57 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:30:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:30:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:30:57 INFO - 'tests': ['a11yr', 12:30:57 INFO - 'ts_paint', 12:30:57 INFO - 'tpaint', 12:30:57 INFO - 'sessionrestore', 12:30:57 INFO - 'sessionrestore_no_auto_restore', 12:30:57 INFO - 'tabpaint']}, 12:30:57 INFO - 'other-e10s': {'tests': ['a11yr', 12:30:57 INFO - 'ts_paint', 12:30:57 INFO - 'tpaint', 12:30:57 INFO - 'sessionrestore', 12:30:57 INFO - 'sessionrestore_no_auto_restore', 12:30:57 INFO - 'tabpaint']}, 12:30:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:30:57 INFO - 'ts_paint', 12:30:57 INFO - 'tpaint', 12:30:57 INFO - 'sessionrestore', 12:30:57 INFO - 'sessionrestore_no_auto_restore', 12:30:57 INFO - 'tabpaint']}, 12:30:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:30:57 INFO - 'ts_paint', 12:30:57 INFO - 'tpaint', 12:30:57 INFO - 'sessionrestore', 12:30:57 INFO - 'sessionrestore_no_auto_restore', 12:30:57 INFO - 'tabpaint']}, 12:30:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:30:57 INFO - 'tests': ['a11yr', 12:30:57 INFO - 'ts_paint', 12:30:57 INFO - 'tpaint', 12:30:57 INFO - 'sessionrestore', 12:30:57 INFO - 'sessionrestore_no_auto_restore', 12:30:57 INFO - 'tabpaint']}, 12:30:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:30:57 INFO - 'tests': ['a11yr', 12:30:57 INFO - 'ts_paint', 12:30:57 INFO - 'tpaint', 12:30:57 INFO - 'sessionrestore', 12:30:57 INFO - 'sessionrestore_no_auto_restore', 12:30:57 INFO - 'tabpaint']}, 12:30:57 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 12:30:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 12:30:57 INFO - 'bloom_basic_ref']}, 12:30:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:30:57 INFO - 'tests': ['tsvgx', 12:30:57 INFO - 'tsvgr_opacity', 12:30:57 INFO - 'tart', 12:30:57 INFO - 'tscrollx', 12:30:57 INFO - 'cart', 12:30:57 INFO - 'tsvg_static']}, 12:30:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:30:57 INFO - 'tsvgr_opacity', 12:30:57 INFO - 'tart', 12:30:57 INFO - 'tscrollx', 12:30:57 INFO - 'cart', 12:30:57 INFO - 'tsvg_static']}, 12:30:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:30:57 INFO - 'talos_options': ['--disable-e10s'], 12:30:57 INFO - 'tests': ['tp5o']}, 12:30:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:30:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:30:57 INFO - 'talos_options': ['--disable-e10s', 12:30:57 INFO - '--xperf_path', 12:30:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:30:57 INFO - 'tests': ['tp5n']}, 12:30:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:30:57 INFO - 'talos_options': ['--xperf_path', 12:30:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:30:57 INFO - 'tests': ['tp5n']}}, 12:30:57 INFO - 'talos.zip': {'path': '', 12:30:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:30:57 INFO - Running post-action listener: _resource_record_post_action 12:30:57 INFO - [mozharness: 2017-04-15 19:30:57.899018Z] Finished populate-webroot step (success) 12:30:57 INFO - [mozharness: 2017-04-15 19:30:57.899137Z] Running create-virtualenv step. 12:30:57 INFO - Running pre-action listener: _resource_record_pre_action 12:30:57 INFO - Running main action method: create_virtualenv 12:30:57 INFO - Creating virtualenv /builds/slave/test/build/venv 12:30:57 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 12:30:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:30:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:30:58 INFO - Using real prefix '/tools/python27' 12:30:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:30:58 INFO - Installing distribute.............................................................................................................................................................................................done. 12:31:01 INFO - Installing pip.................done. 12:31:01 INFO - Return code: 0 12:31:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:31:01 INFO - Reading from file tmpfile_stdout 12:31:01 INFO - Output received: 12:31:01 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) 12:31:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:01 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 0x10935bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf20c8ee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139d30>, '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 0x10905fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10912ebe8>, '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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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 12:31:01 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 12:31:01 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 12:31:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zsBm9qkEfc/Render', 12:31:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:01 INFO - 'HOME': '/Users/cltbld', 12:31:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:01 INFO - 'LOGNAME': 'cltbld', 12:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:01 INFO - 'MOZ_NO_REMOTE': '1', 12:31:01 INFO - 'NO_EM_RESTART': '1', 12:31:01 INFO - 'PAGER': '/bin/cat', 12:31:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:01 INFO - 'PWD': '/builds/slave/test', 12:31:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:01 INFO - 'SHELL': '/bin/bash', 12:31:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i1eE3qZNoC/Listeners', 12:31:01 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 12:31:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:01 INFO - 'USER': 'cltbld', 12:31:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:01 INFO - 'XPC_FLAGS': '0x0', 12:31:01 INFO - 'XPC_SERVICE_NAME': '0', 12:31:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:02 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 12:31:02 INFO - Cleaning up... 12:31:02 INFO - Return code: 0 12:31:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:31:02 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')]} 12:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:02 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')]} 12:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:02 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 0x10935bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf20c8ee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139d30>, '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 0x10905fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10912ebe8>, '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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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 12:31:02 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 12:31:02 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 12:31:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zsBm9qkEfc/Render', 12:31:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:02 INFO - 'HOME': '/Users/cltbld', 12:31:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:02 INFO - 'LOGNAME': 'cltbld', 12:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:02 INFO - 'MOZ_NO_REMOTE': '1', 12:31:02 INFO - 'NO_EM_RESTART': '1', 12:31:02 INFO - 'PAGER': '/bin/cat', 12:31:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:02 INFO - 'PWD': '/builds/slave/test', 12:31:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:02 INFO - 'SHELL': '/bin/bash', 12:31:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i1eE3qZNoC/Listeners', 12:31:02 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 12:31:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:02 INFO - 'USER': 'cltbld', 12:31:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:02 INFO - 'XPC_FLAGS': '0x0', 12:31:02 INFO - 'XPC_SERVICE_NAME': '0', 12:31:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:02 INFO - Downloading/unpacking psutil>=3.1.1 12:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:31:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:31:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:31:06 INFO - Installing collected packages: psutil 12:31:06 INFO - Running setup.py install for psutil 12:31:06 INFO - building 'psutil._psutil_osx' extension 12:31:06 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 12:31:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:31:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:31:07 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 12:31:07 INFO - building 'psutil._psutil_posix' extension 12:31:07 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 12:31:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:31:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:31:07 INFO - ^ 12:31:07 INFO - 1 warning generated. 12:31:07 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 12:31:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:31:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:31:07 INFO - Successfully installed psutil 12:31:07 INFO - Cleaning up... 12:31:07 INFO - Return code: 0 12:31:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:31:07 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')]} 12:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:07 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')]} 12:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:07 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 0x10935bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf20c8ee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139d30>, '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 0x10905fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10912ebe8>, '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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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 12:31:07 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 12:31:07 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 12:31:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zsBm9qkEfc/Render', 12:31:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:07 INFO - 'HOME': '/Users/cltbld', 12:31:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:07 INFO - 'LOGNAME': 'cltbld', 12:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:07 INFO - 'MOZ_NO_REMOTE': '1', 12:31:07 INFO - 'NO_EM_RESTART': '1', 12:31:07 INFO - 'PAGER': '/bin/cat', 12:31:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:07 INFO - 'PWD': '/builds/slave/test', 12:31:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:07 INFO - 'SHELL': '/bin/bash', 12:31:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i1eE3qZNoC/Listeners', 12:31:07 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 12:31:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:07 INFO - 'USER': 'cltbld', 12:31:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:07 INFO - 'XPC_FLAGS': '0x0', 12:31:07 INFO - 'XPC_SERVICE_NAME': '0', 12:31:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:31:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:31:10 INFO - Installing collected packages: mozsystemmonitor 12:31:10 INFO - Running setup.py install for mozsystemmonitor 12:31:10 INFO - Successfully installed mozsystemmonitor 12:31:10 INFO - Cleaning up... 12:31:10 INFO - Return code: 0 12:31:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:10 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 0x10935bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf20c8ee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139d30>, '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 0x10905fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10912ebe8>, '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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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 12:31:10 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 12:31:10 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 12:31:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zsBm9qkEfc/Render', 12:31:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:10 INFO - 'HOME': '/Users/cltbld', 12:31:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:10 INFO - 'LOGNAME': 'cltbld', 12:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:10 INFO - 'MOZ_NO_REMOTE': '1', 12:31:10 INFO - 'NO_EM_RESTART': '1', 12:31:10 INFO - 'PAGER': '/bin/cat', 12:31:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:10 INFO - 'PWD': '/builds/slave/test', 12:31:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:10 INFO - 'SHELL': '/bin/bash', 12:31:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i1eE3qZNoC/Listeners', 12:31:10 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 12:31:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:10 INFO - 'USER': 'cltbld', 12:31:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:10 INFO - 'XPC_FLAGS': '0x0', 12:31:10 INFO - 'XPC_SERVICE_NAME': '0', 12:31:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:10 INFO - Downloading/unpacking jsonschema==2.5.1 12:31:10 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 12:31:10 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 12:31:10 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 12:31:10 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 12:31:10 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 12:31:10 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 12:31:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:31:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:31:13 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 12:31:13 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 12:31:13 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 12:31:13 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 12:31:13 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 12:31:13 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 12:31:13 INFO - Downloading functools32-3.2.3-2.tar.gz 12:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:31:14 INFO - warning: no files found matching '*.txt' 12:31:14 INFO - no previously-included directories found matching 'build' 12:31:14 INFO - no previously-included directories found matching 'dist' 12:31:14 INFO - no previously-included directories found matching '.git*' 12:31:14 INFO - Installing collected packages: jsonschema, functools32 12:31:14 INFO - Running setup.py install for functools32 12:31:14 INFO - warning: no files found matching '*.txt' 12:31:14 INFO - no previously-included directories found matching 'build' 12:31:14 INFO - no previously-included directories found matching 'dist' 12:31:14 INFO - no previously-included directories found matching '.git*' 12:31:14 INFO - Successfully installed jsonschema functools32 12:31:14 INFO - Cleaning up... 12:31:14 INFO - Return code: 0 12:31:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:31:14 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')]} 12:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:14 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')]} 12:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:14 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 0x10935bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf20c8ee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139d30>, '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 0x10905fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10912ebe8>, '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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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 12:31:14 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 12:31:14 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 12:31:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zsBm9qkEfc/Render', 12:31:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:14 INFO - 'HOME': '/Users/cltbld', 12:31:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:14 INFO - 'LOGNAME': 'cltbld', 12:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:14 INFO - 'MOZ_NO_REMOTE': '1', 12:31:14 INFO - 'NO_EM_RESTART': '1', 12:31:14 INFO - 'PAGER': '/bin/cat', 12:31:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:14 INFO - 'PWD': '/builds/slave/test', 12:31:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:14 INFO - 'SHELL': '/bin/bash', 12:31:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i1eE3qZNoC/Listeners', 12:31:14 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 12:31:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:14 INFO - 'USER': 'cltbld', 12:31:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:14 INFO - 'XPC_FLAGS': '0x0', 12:31:14 INFO - 'XPC_SERVICE_NAME': '0', 12:31:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:31:14 INFO - Cleaning up... 12:31:14 INFO - Return code: 0 12:31:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:31:14 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')]} 12:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:14 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')]} 12:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:14 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 0x10935bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf20c8ee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139d30>, '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 0x10905fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10912ebe8>, '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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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 12:31:14 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 12:31:14 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 12:31:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zsBm9qkEfc/Render', 12:31:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:14 INFO - 'HOME': '/Users/cltbld', 12:31:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:14 INFO - 'LOGNAME': 'cltbld', 12:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:14 INFO - 'MOZ_NO_REMOTE': '1', 12:31:14 INFO - 'NO_EM_RESTART': '1', 12:31:14 INFO - 'PAGER': '/bin/cat', 12:31:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:14 INFO - 'PWD': '/builds/slave/test', 12:31:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:14 INFO - 'SHELL': '/bin/bash', 12:31:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i1eE3qZNoC/Listeners', 12:31:14 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 12:31:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:14 INFO - 'USER': 'cltbld', 12:31:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:14 INFO - 'XPC_FLAGS': '0x0', 12:31:14 INFO - 'XPC_SERVICE_NAME': '0', 12:31:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:14 INFO - Downloading/unpacking blobuploader==1.2.4 12:31:14 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 12:31:14 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 12:31:14 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 12:31:14 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 12:31:14 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 12:31:14 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 12:31:17 INFO - Downloading blobuploader-1.2.4.tar.gz 12:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:31:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:31:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:31:18 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 12:31:18 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 12:31:18 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 12:31:18 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 12:31:18 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 12:31:18 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 12:31:18 INFO - Downloading docopt-0.6.1.tar.gz 12:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:31:18 INFO - Installing collected packages: blobuploader, requests, docopt 12:31:18 INFO - Running setup.py install for blobuploader 12:31:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:31:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:31:18 INFO - Running setup.py install for requests 12:31:19 INFO - Running setup.py install for docopt 12:31:19 INFO - Successfully installed blobuploader requests docopt 12:31:19 INFO - Cleaning up... 12:31:19 INFO - Return code: 0 12:31:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31: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')]} 12:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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')]} 12:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:19 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 0x10935bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf20c8ee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139d30>, '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 0x10905fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10912ebe8>, '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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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 12:31:19 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 12:31:19 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 12:31:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zsBm9qkEfc/Render', 12:31:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:19 INFO - 'HOME': '/Users/cltbld', 12:31:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:19 INFO - 'LOGNAME': 'cltbld', 12:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:19 INFO - 'MOZ_NO_REMOTE': '1', 12:31:19 INFO - 'NO_EM_RESTART': '1', 12:31:19 INFO - 'PAGER': '/bin/cat', 12:31:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:19 INFO - 'PWD': '/builds/slave/test', 12:31:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:19 INFO - 'SHELL': '/bin/bash', 12:31:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i1eE3qZNoC/Listeners', 12:31:19 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 12:31:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:19 INFO - 'USER': 'cltbld', 12:31:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:19 INFO - 'XPC_FLAGS': '0x0', 12:31:19 INFO - 'XPC_SERVICE_NAME': '0', 12:31:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:19 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-ZdFSmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-5v_XAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-5nR4lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-9MI08P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-6QW5RP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-bbzY7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-xpFtv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-bYHVK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-vuQZ9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-DiUvNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:21 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-1H8Zoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:21 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-95_QnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:21 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-OnSPhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:21 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-ThHri9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:21 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-lLaN52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:21 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-DfBAlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:21 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-ixBFCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:31:21 INFO - Running setup.py install for manifestparser 12:31:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:31:21 INFO - Running setup.py install for mozcrash 12:31:22 INFO - Running setup.py install for mozdebug 12:31:22 INFO - Running setup.py install for mozdevice 12:31:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:31:22 INFO - Running setup.py install for mozfile 12:31:22 INFO - Running setup.py install for mozhttpd 12:31:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:31:22 INFO - Running setup.py install for mozinfo 12:31:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:31:22 INFO - Running setup.py install for mozInstall 12:31:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:31:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:31:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:31:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:31:22 INFO - Running setup.py install for mozleak 12:31:23 INFO - Running setup.py install for mozlog 12:31:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:31:23 INFO - Running setup.py install for moznetwork 12:31:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:31:23 INFO - Running setup.py install for mozprocess 12:31:23 INFO - Running setup.py install for mozprofile 12:31:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:31:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:31:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:31:23 INFO - Running setup.py install for mozrunner 12:31:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:31:23 INFO - Running setup.py install for mozscreenshot 12:31:23 INFO - Running setup.py install for moztest 12:31:24 INFO - Running setup.py install for mozversion 12:31:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:31:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:31:24 INFO - Cleaning up... 12:31:24 INFO - Return code: 0 12:31:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:24 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 0x10935bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf20c8ee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139d30>, '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 0x10905fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10912ebe8>, '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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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 12:31:24 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 12:31:24 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 12:31:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zsBm9qkEfc/Render', 12:31:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:24 INFO - 'HOME': '/Users/cltbld', 12:31:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:24 INFO - 'LOGNAME': 'cltbld', 12:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:24 INFO - 'MOZ_NO_REMOTE': '1', 12:31:24 INFO - 'NO_EM_RESTART': '1', 12:31:24 INFO - 'PAGER': '/bin/cat', 12:31:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:24 INFO - 'PWD': '/builds/slave/test', 12:31:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:24 INFO - 'SHELL': '/bin/bash', 12:31:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i1eE3qZNoC/Listeners', 12:31:24 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 12:31:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:24 INFO - 'USER': 'cltbld', 12:31:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:24 INFO - 'XPC_FLAGS': '0x0', 12:31:24 INFO - 'XPC_SERVICE_NAME': '0', 12:31:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-t66xQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:24 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)) 12:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-MiLTfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:24 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)) 12:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-CDq_og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:24 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)) 12:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-tmkD06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-zI3g1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:25 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)) 12:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-P0PgjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:25 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)) 12:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-qF5tjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:25 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)) 12:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-Xd2fh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:25 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)) 12:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-25LUyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:25 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)) 12:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-j1dSTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:25 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)) 12:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-rsQFwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:25 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)) 12:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-9_xN9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:25 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)) 12:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-BO6kRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:26 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)) 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:26 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-OBNWAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:26 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)) 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:26 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-UapsIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:26 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)) 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:26 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-n6FwH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:26 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)) 12:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:26 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-PoQpBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:26 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)) 12:31:26 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)) 12:31:26 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)) 12:31:26 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)) 12:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:31:26 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 12:31:26 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 12:31:26 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 12:31:26 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 12:31:26 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 12:31:26 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 12:31:29 INFO - Downloading blessings-1.6.tar.gz 12:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:31:29 INFO - Installing collected packages: blessings 12:31:29 INFO - Running setup.py install for blessings 12:31:29 INFO - Successfully installed blessings 12:31:29 INFO - Cleaning up... 12:31:29 INFO - Return code: 0 12:31:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:31:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:29 INFO - Reading from file tmpfile_stdout 12:31:29 INFO - Current package versions: 12:31:29 INFO - blessings == 1.6 12:31:29 INFO - blobuploader == 1.2.4 12:31:29 INFO - docopt == 0.6.1 12:31:29 INFO - functools32 == 3.2.3-2 12:31:29 INFO - jsonschema == 2.5.1 12:31:29 INFO - manifestparser == 1.1 12:31:29 INFO - mozInstall == 1.12 12:31:29 INFO - mozcrash == 1.0 12:31:29 INFO - mozdebug == 0.1 12:31:29 INFO - mozdevice == 0.50 12:31:29 INFO - mozfile == 1.2 12:31:29 INFO - mozhttpd == 0.7 12:31:29 INFO - mozinfo == 0.9 12:31:29 INFO - mozleak == 0.1 12:31:29 INFO - mozlog == 3.4 12:31:29 INFO - moznetwork == 0.27 12:31:29 INFO - mozprocess == 0.25 12:31:29 INFO - mozprofile == 0.28 12:31:29 INFO - mozrunner == 6.13 12:31:29 INFO - mozscreenshot == 0.1 12:31:29 INFO - mozsystemmonitor == 0.3 12:31:29 INFO - moztest == 0.8 12:31:29 INFO - mozversion == 1.4 12:31:29 INFO - psutil == 3.1.1 12:31:29 INFO - requests == 1.2.3 12:31:29 INFO - wsgiref == 0.1.2 12:31:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:29 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')]} 12:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:29 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')]} 12:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:29 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 0x10935bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf20c8ee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139d30>, '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 0x10905fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10912ebe8>, '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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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 12:31:29 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 12:31:29 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 12:31:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zsBm9qkEfc/Render', 12:31:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:29 INFO - 'HOME': '/Users/cltbld', 12:31:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:29 INFO - 'LOGNAME': 'cltbld', 12:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:29 INFO - 'MOZ_NO_REMOTE': '1', 12:31:29 INFO - 'NO_EM_RESTART': '1', 12:31:29 INFO - 'PAGER': '/bin/cat', 12:31:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:29 INFO - 'PWD': '/builds/slave/test', 12:31:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:29 INFO - 'SHELL': '/bin/bash', 12:31:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i1eE3qZNoC/Listeners', 12:31:29 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 12:31:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:29 INFO - 'USER': 'cltbld', 12:31:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:29 INFO - 'XPC_FLAGS': '0x0', 12:31:29 INFO - 'XPC_SERVICE_NAME': '0', 12:31:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:29 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)) 12:31:29 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)) 12:31:29 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)) 12:31:29 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)) 12:31:29 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)) 12:31:29 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)) 12:31:29 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)) 12:31:29 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)) 12:31:29 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)) 12:31:29 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)) 12:31:29 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)) 12:31:29 INFO - Cleaning up... 12:31:29 INFO - Return code: 0 12:31:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:31:29 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')]} 12:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:29 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')]} 12:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10935bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf20c8ee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109139d30>, '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 0x10905fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10912ebe8>, '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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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 12:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:31:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zsBm9qkEfc/Render', 12:31:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:29 INFO - 'HOME': '/Users/cltbld', 12:31:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:29 INFO - 'LOGNAME': 'cltbld', 12:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:29 INFO - 'MOZ_NO_REMOTE': '1', 12:31:29 INFO - 'NO_EM_RESTART': '1', 12:31:29 INFO - 'PAGER': '/bin/cat', 12:31:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:29 INFO - 'PWD': '/builds/slave/test', 12:31:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:29 INFO - 'SHELL': '/bin/bash', 12:31:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i1eE3qZNoC/Listeners', 12:31:29 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 12:31:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:29 INFO - 'USER': 'cltbld', 12:31:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:29 INFO - 'XPC_FLAGS': '0x0', 12:31:30 INFO - 'XPC_SERVICE_NAME': '0', 12:31:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:31:30 INFO - Cleaning up... 12:31:30 INFO - Return code: 0 12:31:30 INFO - Running post-action listener: _resource_record_post_action 12:31:30 INFO - Running post-action listener: _start_resource_monitoring 12:31:30 INFO - Starting resource monitoring. 12:31:30 INFO - [mozharness: 2017-04-15 19:31:30.290190Z] Finished create-virtualenv step (success) 12:31:30 INFO - [mozharness: 2017-04-15 19:31:30.291162Z] Running install step. 12:31:30 INFO - Running pre-action listener: _resource_record_pre_action 12:31:30 INFO - Running main action method: install 12:31:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:30 INFO - Reading from file tmpfile_stdout 12:31:30 INFO - Detecting whether we're running mozinstall >=1.0... 12:31:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:31:30 INFO - Reading from file tmpfile_stdout 12:31:30 INFO - Output received: 12:31:30 INFO - Usage: mozinstall [options] installer 12:31:30 INFO - Options: 12:31:30 INFO - -h, --help show this help message and exit 12:31:30 INFO - -d DEST, --destination=DEST 12:31:30 INFO - Directory to install application into. [default: 12:31:30 INFO - "/builds/slave/test"] 12:31:30 INFO - --app=APP Application being installed. [default: firefox] 12:31:30 INFO - mkdir: /builds/slave/test/build/application 12:31:30 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'] 12:31:30 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 12:31:50 INFO - Reading from file tmpfile_stdout 12:31:50 INFO - Output received: 12:31:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:31:50 INFO - Running post-action listener: _resource_record_post_action 12:31:50 INFO - [mozharness: 2017-04-15 19:31:50.317640Z] Finished install step (success) 12:31:50 INFO - [mozharness: 2017-04-15 19:31:50.317806Z] Running run-tests step. 12:31:50 INFO - Running pre-action listener: _resource_record_pre_action 12:31:50 INFO - Running main action method: run_tests 12:31:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:31:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:31:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:31:50 INFO - 2017-04-15 12:31:50.332 screenresolution[1630:8876] starting screenresolution argv=screenresolution get 12:31:50 INFO - 2017-04-15 12:31:50.335 screenresolution[1630:8876] Display 0: 1600x1200x32@60 12:31:50 INFO - 2017-04-15 12:31:50.341 screenresolution[1631:8879] starting screenresolution argv=screenresolution list 12:31:50 INFO - Available Modes on Display 0 12:31:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:31:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:31:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:31:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:31:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:31:50 INFO - Intel Iris: 12:31:50 INFO - Chipset Model: Intel Iris 12:31:50 INFO - Type: GPU 12:31:50 INFO - Bus: Built-In 12:31:50 INFO - VRAM (Dynamic, Max): 1536 MB 12:31:50 INFO - Vendor: Intel (0x8086) 12:31:50 INFO - Device ID: 0x0a2e 12:31:50 INFO - Revision ID: 0x0009 12:31:50 INFO - Displays: 12:31:50 INFO - Display: 12:31:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:31:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:31:50 INFO - Display Serial Number: 1600x1200 60 12:31:50 INFO - Main Display: Yes 12:31:50 INFO - Mirror: Off 12:31:50 INFO - Online: Yes 12:31:50 INFO - Rotation: Supported 12:31:50 INFO - Return code: 0 12:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:31:50 INFO - Python 2.7.3 12:31:50 INFO - Return code: 0 12:31:50 INFO - grabbing minidump binary from tooltool 12:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:31:50 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 0x109139d30>, '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 0x10905fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10912ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:31:50 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 12:31:50 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 12:31:50 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 12:31:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:31:50 INFO - Return code: 0 12:31:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:31:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:31:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:31:50 INFO - ENV: RUST_BACKTRACE is now 1 12:31:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:31:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:31:50 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/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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 12:31:50 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/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0138 --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 12:31:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zsBm9qkEfc/Render', 12:31:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:31:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:31:50 INFO - 'HOME': '/Users/cltbld', 12:31:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:31:50 INFO - 'LOGNAME': 'cltbld', 12:31:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:31:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:50 INFO - 'MOZ_NO_REMOTE': '1', 12:31:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:31:50 INFO - 'NO_EM_RESTART': '1', 12:31:50 INFO - 'PAGER': '/bin/cat', 12:31:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:50 INFO - 'PWD': '/builds/slave/test', 12:31:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:31:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:31:50 INFO - 'RUST_BACKTRACE': '1', 12:31:50 INFO - 'SHELL': '/bin/bash', 12:31:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i1eE3qZNoC/Listeners', 12:31:50 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 12:31:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:31:50 INFO - 'USER': 'cltbld', 12:31:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:31:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:50 INFO - 'XPC_FLAGS': '0x0', 12:31:50 INFO - 'XPC_SERVICE_NAME': '0', 12:31:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:31:50 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/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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 12:31:50 INFO - mozversion application_buildid: 20170415110113 12:31:50 INFO - mozversion application_changeset: d65b53cf8fd9f7747c7ee4e3ea96f12434917daa 12:31:50 INFO - mozversion application_display_name: Nightly 12:31:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:31:50 INFO - mozversion application_name: Firefox 12:31:50 INFO - mozversion application_remotingname: firefox 12:31:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:31:50 INFO - mozversion application_vendor: Mozilla 12:31:50 INFO - mozversion application_version: 55.0a1 12:31:50 INFO - mozversion platform_buildid: 20170415110113 12:31:50 INFO - mozversion platform_changeset: d65b53cf8fd9f7747c7ee4e3ea96f12434917daa 12:31:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:31:50 INFO - mozversion platform_version: 55.0a1 12:31:50 INFO - using testdate: 1492284710 12:31:50 INFO - actual date: 1492284710 12:31:50 INFO - starting webserver on 'localhost:49243' 12:31:50 INFO - SUITE-START | Running 2 tests 12:31:50 INFO - TEST-START | dromaeo_css 12:31:50 INFO - operating with platform_type : mac_ 12:31:50 INFO - Initialising browser for dromaeo_css test... 12:31:50 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/tmpVUDQc3/profile http://localhost:49243/getInfo.html) 12:31:53 INFO - PID 1641 | __metrics Screen width/height:1600/1200 12:31:53 INFO - PID 1641 | colorDepth:24 12:31:53 INFO - PID 1641 | Browser inner width/height: 1024/689 12:31:53 INFO - PID 1641 | __metrics 12:31:53 INFO - PID 1641 | 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" 12:31:53 INFO - PID 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:31:54 INFO - TEST-INFO | 1641: exit 0 12:31:54 INFO - Browser initialized. 12:31:54 INFO - Running cycle 1/1 for dromaeo_css test... 12:31:54 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/tmpVUDQc3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:32:07 INFO - PID 1644 | RSS: Main: 241254400 12:32:07 INFO - PID 1644 | 12:35:11 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 12:35:13 INFO - PID 1644 | RSS: Main: 461414400 12:35:13 INFO - PID 1644 | 12:36:56 INFO - PID 1644 | ************************* 12:36:56 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 12:36:56 INFO - PID 1644 | 12:36:56 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:36:56 INFO - PID 1644 | Full stack: 12:36:56 INFO - PID 1644 | ************************* 12:36:56 INFO - PID 1644 | ************************* 12:36:56 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 12:36:56 INFO - PID 1644 | 12:36:56 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:36:56 INFO - PID 1644 | Full stack: 12:36:56 INFO - PID 1644 | ************************* 12:36:56 INFO - PID 1644 | ************************* 12:36:56 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 12:36:56 INFO - PID 1644 | 12:36:56 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:36:56 INFO - PID 1644 | Full stack: 12:36:56 INFO - PID 1644 | ************************* 12:36:56 INFO - PID 1644 | ************************* 12:36:56 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 12:36:56 INFO - PID 1644 | 12:36:56 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:36:56 INFO - PID 1644 | Full stack: 12:36:56 INFO - PID 1644 | ************************* 12:38:16 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 12:38:17 INFO - PID 1644 | RSS: Main: 370778112 12:38:17 INFO - PID 1644 | 12:41:19 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 12:41:20 INFO - PID 1644 | RSS: Main: 359256064 12:41:20 INFO - PID 1644 | 12:44:22 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 12:44:22 INFO - PID 1644 | RSS: Main: 362737664 12:44:22 INFO - PID 1644 | 12:47:26 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 12:47:27 INFO - PID 1644 | RSS: Main: 330756096 12:47:27 INFO - PID 1644 | 12:50:29 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 12:50:29 INFO - PID 1644 | RSS: Main: 373055488 12:50:29 INFO - PID 1644 | 12:50:29 INFO - PID 1644 | __start_tp_report 12:50:29 INFO - PID 1644 | _x_x_mozilla_page_load 12:50:29 INFO - PID 1644 | _x_x_mozilla_page_load_details 12:50:29 INFO - PID 1644 | |i|pagename|runs| 12:50:29 INFO - PID 1644 | |0;dojo.html;3475.0617333320006;3500.4049311617023;3501.842417091231;3520.489529018291;3561.590417102034;5981.671008094553;6108.129596501685;6203.844903877405;6247.875042499148;6253.09330147129;6080.756769729205;6136.325004249529;6136.417040381168;6137.324894261627;6144.723487443064;5250.238715386276;5261.158214685651;5286.074936886049;5301.761420736076;5413.675179489223;5375.543078838284;5390.9191362129595;5395.838124856261;5397.649152805075;5403.729813509309;4788.545088216614;5041.890784027508;5388.976094542044;5392.703401312926;5397.62216644835;5391.514763671288;5394.217838413408;5394.622376433632;5403.2705584746345;5412.458754124556;5248.475152484759;5331.973340133274;5340.519353258225;5348.358197016383;5351.598630102758;6260.937390626126;6281.685915704196;6290;6295.464885484739;6295.874082518324;6379.298277189506;6531.823165498279;6602.603843769341;6604.867902641969;6633.93366066338;5446.346438427414;5864.794732184396;6528.08606795049;6638.767643132467;6718.428933540655;6196.504279657616;6313.747450101991;6315.115883776275;6319.494440444753;6334.239891213084;6849.554778939353;6850;6852.246252912176;6866.244713081557;6888.517803753689;6313.2424109107205;6400;6418.679066046679;6439.8068057958335;6496.123023391876;6572.539922205496;6611.570247933869;6679.599224046573;6684;6685.799426017227;6536.901946470807;6539.542232043711;6571.83570410734;6572.86854262912;6583.210014798255;6323.9051414228825;6378.266499352541;6620.933790662032;6646.202455705346;6663.833404164935;4455.598996090367;5342.065138600807;5346.973265133727;5355.3841308249275;5368.1679339702405;3917.275304068756;4691.202495575761;4691.906161876744;4727.078219747116;4729.69256998294;6160.199174107427;6198.2252218472695;6204.317525072239;6211.223597050369;6216.44052035319;6374.107624932513;6440.4847612190915;6475.996220585816;6487.805365839033;6502.837429064217;6053.061775424816;6104.786332478342;6112.327643959161;6124.693765311717;6129.295131059896;5713.485786279255;5715.028445164332;5717.056685646821;5717.714114294268;5723.456271654186;6505.41451269388;6553.115329430466;6558.967205163944;6573.901391479228;6577.638229897401;6432.09950606906;6564.9671751642845;6659.900101498384;6677.432418244503;6688.264290927897;6752.763653272308;6771.153605799275;6777.356151165632;6780.93219067803;6787.932120678927;6503.349665033648;6516.934830651822;6519.250286217146;6519.902201466887;6532;6455.709493072917;6539.247986481425;6552.3775241352;6553.4101930826455;6553.868922621617;5224.686518808731;6219.968900155471;6334.904976425265;6361.141245931925;6380.617162970237;6426.582272152295;6445.1943507061615;6461.450776683847;6465.3857883501;6468.579542329733;6349.952257877399;6350.396712312323;6354.110424540476;6355.173827402593;6360.918643830468;6286.37136286386;6371.522135839923;6441.935580644321;6460.45086167681;6470.935290647033;6009.879802404015;6259.812205633838;6268.091126786499;6334.841628959313;6358.491320694426 12:50:29 INFO - PID 1644 | |1;ext.html;798.4490701416023;821.2116368286443;1119.9944000280002;1145.4272863568217;1147.1453766943628;34365.969020929384;38032.04919877008;38160;38355.23289534207;38727.61272387275;40134.39798403026;40467.797661011726;40480;40487;40538.39192412116;6199.845003874917;8693.434926729775;8847;8864.512451815148;8886.111388861094;5267.76295066721;7409;8661.740147795545;8907.465552066897;8908.8663670045;8927.687530936419;8979.461232326048;8989.101089890992;8990.775230619221;8991.235744961687;7444.441666874979;8932.732018039469;8938.1508756668;8953.820923581558;8956.328275379372;7149.964250178716;8567;8603.569821508961;8655.783605409852;8657;38358.616413835785;38551.42172867409;38570.421443678366;38623.61376386228;38628.61371386278;3578.6600272974024;3623.1304486923214;3633;3638.308721342963;3641.0169254301454;30394.84802575995;30433;30470;30482.695173048207;30510.694893051008;3131.841218749055;3168.2237851726245;3193.0420873737785;3203.2792621660174;3208.454562724319;255834.72082639468;261585.384146158;262236;262592;262610;40086.39870401946;41090.79454602708;49228;49514;49557;42908.78545607314;51933.48066519287;52403.73798131061;52690;52792.472075279526;14509.201993890227;14631.780523292158;14644.853551464348;14648.121112733057;14718.411263549553;11896.940515297369;11905.761884762429;11916.940415297868;11921.940390298167;11923;13276.20342779417;13292.003099767362;13302.467901284033;13336.466071446588;13378.39797209128;5680.466274105968;5684.602077854511;5720.597349113383;5733.913991290134;5737.5983681141915;879.7272845417941;1008.8335424654849;1022.9846552301573;1037.061459379248;1068.076114161245;23746.58090488296;24606.62341012356;24648.65724451867;24721.128445397142;24735.68721324542;1007.7201953519136;1109.134874797643;1129.7119234595125;1159.8840115988503;1170.5961443302047;11868;12078.154529182873;12504.749905001849;12541;12605.873941260654;309441;309611;309627;310656;312289;55465.44534554683;55532;55568.88862222733;55624.721876391166;55668.6082847924;1270.7140893298933;1326.9535566255329;1521.9467318643794;1524.809398825147;1541.0907564536976;23990.760092398854;24047.398815029763;24333.14833980802;24380.26859194227;24450.877745611157;39360.80319598383;39362.01594960149;39366.83482408495;39373.21253574855;39695.40456893091;272861;273385;273600;273643;273691;29325.26686832846;30612.08163755091;31029;35001.47497787586;35817.77640012307;42733.78633106814;43640.56359436492;43753.90615234645;43851;43979;29545.2613684651;29572.408551828412;30265.940692076554;30449.08652740421;30773.692263077082;27128.72871271341;29761;30132.11129556544;30397;30553.083407497812;35681.1079723009;36484.63515364812;36549.08627284339;36590.26819463649;36650.8167459161;29413.558796618498;29699.406011880073;30461.695383045884;30564;30579.54130688086;22829.086836526352;23219;23499.060037598305;23760.881195593913;23974.40063998414 12:50:29 INFO - PID 1644 | |2;jquery.html;388.39399084784407;439.117374078103;440.5945035337274;443.6694662476456;456.808140580956;19139.808601913977;21709.565808683838;21959.792211428365;23007.42481437965;23324.8833755831;22451.32646020618;22774.089036438523;22801.54396912065;23080.19219327324;23434.414139646477;4852.4662287148385;6103.657195417001;6139.72371243294;6298.401651843067;6368.74525019001;5404.91892621611;6189.938100619003;6237.656928868911;6297.811065668015;6320.589161704497;6092.786752463665;6180.629162250257;6201.193844800169;6274.058891166316;6275.905861412082;6153.538484613627;6177.876442471125;6188.319284878659;6256.812295631115;6258.561900666955;5495.807646732345;5552.555795536347;5556.749946252388;5557.194206840026;5569.637973531708;22018.889905550368;27135.321616959536;27215.86392068027;27383.04159354433;27681;2221.589006033889;2267.7278726552754;2267.7958983691547;2268.3421807675754;2274.3404412720292;17256.56858578533;17786.37747678838;18025.459236222803;18029.909850450797;18300;1820.6436205027208;2117.4177101297114;2179.1283486605485;2182.3125715399597;2196.2642514757576;123249;146816.2659186708;147628.99999999892;147712;149232.2538387312;11101.222914395914;11655.242409243541;11663.533458661728;12162.635120946386;12233.204841685261;14546.054506457047;14909.552713418614;14942.402303907722;14948.551543453714;14967.625809354853;7383.483156179123;8647.870281945776;8821.867671984925;8907.910920890708;9026.413283136575;8383.542863955015;8405.831883362298;8415.368847336475;8599.699010534601;8633.352498562634;7561.6597253122645;7692.423023294195;7735.458517903693;7761.8447631047065;7770.746483519716;1781.8129096444686;2106.6629339305637;2134.8185404240503;2137.540428807814;2152.5479649273516;987.3088837813559;992.9702108936743;999.5751805482786;1039.4698703661036;1043.7808060307268;19605.019749012492;20101.698474522895;21023.78976210249;21095.578088438146;21180.835054071867;981.1758123176566;1023.7133602591286;1025.4052649463292;1052.315994603514;1059.4067322299536;10288.794224115476;10551.997560231766;10819.83770243447;10854.511546980404;11033.83449248262;540600;549163;555813;557797;558952;86885;118293.22560161604;118466;127476;133355;1169.7309618787726;1185.1822242652715;1241.4847838147248;1242.8384310039817;1243.8569564500017;17054.2325595346;17189.742153867453;22435.32694019182;22560.548789024455;22749.15635545557;42328.57671423369;42789.50236741699;55543.88912221814;55720.72139639276;56091.71954140203;76480.55837487215;77565.61217193877;77752.2224777745;78032;79114.6044269775;8612.18184272493;8647.870281945901;8783.780405489913;8929.06244844308;8955.686550970684;11933.925946664842;13231.67683231669;13907.791383129463;14044.508442204473;14202.147871127352;9378.531073446436;9808.185485685171;11853.703657408289;11929.82105268439;12116.394180291127;8810.75325791919;9266.397684150508;10113.89886101159;11056.447177641247;11270.380129092979;11712.297262164297;11773.117016223989;12007.939960300142;12056.216345937486;12071.879281207426;8362.707305244287;8384.790380240544;8724.302055835391;8840;8866.512341821262;9560.378575392577;10100.646477373257;11511.136664750346;11871.762564748484;11927.165098443025 12:50:29 INFO - PID 1644 | |3;mootools.html;1226.2274766896855;1475.240251270595;1494.1184701026393;1494.559105064006;1496.6034000989737;11246.325220486766;11730.00294974927;11733.941330293357;11740.589079382224;11749.647510574685;11242.100631949445;11402.258853174539;11676.065914726802;11677.708057298572;11677.708057298572;2462.8276020678513;2508.611165269386;2509.6611957385794;2515.4591762771;2516.471540976397;2110.0715685098585;2200.5928903152967;2420.334408037786;2534.594464885619;2540.428403609182;2022.9393118206478;2183.9890800545977;2206.6248737714545;2533.936651583707;2534.7845433138114;2493;2496.8876400562017;2496.9126080587275;2499.862562534043;2503.824732268742;2433.0997530913496;2475.405902583367;2478.702555693328;2479.652848601197;2479.7148327942336;11613.245139066019;11852.525898964032;11859.940700296444;11878.762424751456;11891.702707432298;6475.093486911836;6729.831754206135;6734.528582999192;6741.662916854187;6750.291219421988;4062.451569038172;4223.176480586287;4352.477702675699;4432.734035957853;4449.888752781174;1250.67428525763;1254.7239607286383;1294.359292150382;1296.5850927703138;1305.5039085147582;16486.67026659472;16588.917055414644;16601.086940218283;16618.916905415517;16653.583660408465;5516.448355164452;5549.916751248735;5725.828225153252;5824.88350232993;5834.445727655951;11199.160062995308;11238.38188899602;12321;12332.260064395985;12333.383330833602;6626.304238055031;6630.535862489676;6630.701618427182;6644.368784965421;6646.900296495556;6152.2924863640355;6176.011838105882;6177;6234.844128896814;6272.372762723691;4283.657307415399;4411.338299255073;4413.536578659258;4477.32840073985;4478.507364189936;1276.234259444326;1302.5245785288303;1303.69363199648;1317.0583033131356;1320.0825426328802;748.4611080022376;769.5959621198804;770.8304173081913;770.9014654117859;772.6098320348301;5793.391693872167;5820.708964551755;6016.338202797689;6045.546584006217;6078.908816367758;579.1891352107084;590.6574186971546;601.3775742106899;602.2321540036401;606.7663949379521;3608.6752192302292;3964.623360780721;3986.64120229175;4094.160697057096;4114.156597897424;14402.639934001734;14746.262686865613;15083.773743393858;15274.541763747106;15292.923535382475;15012.099274043592;15149.469768558047;15318.004329718533;15324.080555166725;15338.846611533965;8473.322134229247;8650.480971141626;8666.913330866737;8673.089325620846;8705.695300664447;5850.64896106235;5884.617499862496;6241.157443745218;6369.235691716838;6467.773627923;13113.606591802261;13306.46774129024;13419.798703019658;13452.730945381234;13492.190468571916;13823.032387732763;13922.164670119826;13956.581302560939;13984.300784960507;14154.363053662404;8762.299016078827;8774.34192435557;8806.251468625238;8873.778155545904;8912.376133670581;10627.787444250916;10792.892071079188;10798.40608766494;10798.67603971882;10810.621628242974;8967.282617390723;9205.815883682422;9269.953650231706;9332.766680833034;9426.81146377055;8880.200781929658;8976.41653292534;9057.275417966415;9064.229540489132;9065.32010099232;7945.284924356604;8166.142555031636;8279.751607451786;8279.793005174919;8282.17178282167;5981.611195272293;6106.175666284995;6110.541709371903;6120.112583675431;6179.62922224668;6007.729652165751;6062.484688801501;6156.476699480594;6237.937620623736;6411.134496843053 12:50:29 INFO - PID 1644 | |4;prototype.html;392.8195771706023;396.2471304521409;398.96209860063294;405.6511400195831;421.4984168839079;5166.380034395868;5701.429857014296;6015.278166620006;6055.333913269542;6073.117333626574;5728;5759.049756790135;5863.560232982532;5902.734376953037;5942.2869255689375;3534.8232588370606;4577.901303687125;4583.839565615204;4599.413202445151;4617.284320930261;4370.322599997005;4438.600525952664;4561.498235194126;4601.884952876171;4612.630989520847;4115.835366585333;4512.45850497939;4530.116627257686;4546.749928753918;4568.383268258793;4510.526394728556;4529.456465224194;4543.137313701367;4558.088382323532;4559.133764584718;3583.104223944014;3772.8302226399605;4040.272750904836;4059.4316795648633;4060.7157498975084;5568.749406276727;5669.603127781057;5703.287089113861;5726.513246374063;5785.161151633031;5147.330846989905;5155.664881782672;5168.22476628505;5170.327857378555;5184.455632158607;4679.391679081732;5482.342118945712;5931.932252194603;5996.194319447415;6307.432331090178;4089.6114869087387;4299.398084268205;4313.805878735433;4317.948974237243;4318.654507639413;5674.801381951653;6629.900551491732;6704.228728983761;6711.9664401678165;6723.7646682365885;4268.786560671954;4352.412424322739;4370.694051416434;4378.190034843564;4385.539518350527;3676.7793932364143;4016.457778199964;4162.209180255742;4461.665375096881;4463.754493502824;5156.845294641167;5180.067587834226;5191.325127733446;5196.636235463557;5226.3205783248695;4985.451600323961;5388.595855310868;6030.5778595497895;6074.542109893682;6382.329855365213;1436.5403071017383;1462.232328027794;1476.7637178051675;1508.3212554350587;1513.8940274180923;970.8883478399933;998.9200863930868;1009.8333774927055;1017.6641708236265;1017.8982101789762;4808.495108013678;5003.699778013331;5220.243064755589;5882.323532793784;5965.403459654087;5981.825720751519;6539.574927629689;6547.967260163764;6569.025739427673;6587.769428069994;5168.7415629218385;5345.251664766935;5957;5961.850953726192;5985.503624093976;2538.9111381101943;3113.8910138145056;3378.35811195872;3408.608010078823;3413.7098346640814;6412.583182093243;6557.573757705733;6639.302873198341;6675.899861502081;6706.317473010738;5201.713905735145;5961.485625796121;6630;6637.867242655217;6725.730970761115;6170.382961703794;6633.834154146185;6641.601503909781;6652.8669426611195;6726.3946244837225;5608.747606357642;6445.12990746262;6471.676416179078;6532.902006470002;6542.855000375011;5354.143337066051;5994.280686317496;6297.244330680348;6489.643069631215;6490.221173459215;6481.152871431619;6671.733130674913;6675.4325882300545;6737.191537015589;6759.425448836904;3635.345637785224;3840.6543411093135;4321.277595115057;4356.4336636237085;4359.04101097758;5104.132297509506;5434.864128396822;6582.374674406115;6590.736370545124;6627.502937279627;5871.94128058714;6033.431307860076;6310.842228944313;6326.493880489457;6359.109724638647;5758.366579676316;6300.936990630035;6303.968480157753;6350.396712312323;6524.4454221389815;5868.075670708605;5918.378570250234;6228.283747369111;6233.2208473940755;6242.500599952084;5558.861028474321;5707.771689132388;6044.818655440344;6382.32985536512;6399.360063993563;5122.8975420492125;5911.645301281937;6113.585133872007;6213;6216.813495595139 12:50:29 INFO - PID 1644 | |5;yui.html;722.5050840174484;867.8568036274015;880.1858281089994;881.963692661123;891.3626756868839;13225.404856781444;18087.095645217752;18773.906130469346;18818.341358052436;18838.43484695458;16211.594710132253;17590.472285831413;17841.91079044603;17884.195211215494;17885.64228715425;987.9802403951917;1002.809466201423;1024.3751311699893;1024.4365598920601;1026.6150193677372;1030.7938412317528;1033.405791669789;1033.9276250662456;1037.165082108902;1037.3361048928691;1083.3175099687187;1087.1194332590626;1089.5641743302704;1091.0235339371259;1094.7810437912449;1078.0620859851979;1080.529969463286;1082.951267192978;1083.6748975307455;1083.9458027098653;801.1187693537121;804.2399932064202;806.1495122645606;807.64059993303;807.9111297757242;15785.763213551805;16825.91587042057;17297.91351043237;17376.21807018687;17563.5609109772;15814.683706325925;15953.760693589606;17477.650446991116;17539.473815785546;17551.47345579622;13913.026088173832;14025.158490490603;14310;14419.062760920506;14462.855371446256;3562;3596.7841929484316;3604.297162053401;3604.711623070148;3611.6388361163936;111756;114014;116436.41781791122;117250.41374793071;117323;10379.636712715019;11186.944065279622;11342.716432089264;13229.404676789567;13802.723945521033;20123.798762012193;21095.578088438146;24597.50804983926;25291.367715807253;25307.74692253054;7952.681892724342;8094.473859199134;8097.635606397726;8105.189481051965;8105.513669179868;4011.2178125265877;4021.617946295097;4045.19096180765;4091;4096.91806163881;4354.455693038371;4463.263561512379;4469.709468884512;4469.994251293433;4473;925.4771054354268;961.5913236874301;965.6089283839916;971.5482300730054;972.1493693018608;632.2886752403546;651.4755621724463;660.6762686283687;661.7319985405918;686.3136863136863;11432.714182145513;11941.104417168746;12027.939860300643;12029.03767698582;12230.571929982409;647.6923461355818;654.4437228355955;659.7229163751236;681.8329509270261;686.0258433025017;5105.183170692746;5163.767630456563;5172.120739474223;5635.098384258499;5644.774209031675;91848;92944;94046;97462;98954.58885994628;83345.16654833495;84573;85038;85702;88750.55624721835;45502.08995820065;71549;77816.61091694619;78526.6073669628;80889.19110808935;10423.374597524173;10620.468976551296;12082.100295929089;12446.688832779253;12503.312317822243;39043;39589;40786.388204176365;41129.97175070647;42549.57450425456;71174.57650847058;71346.64326678333;71691.64154179196;72555;73127;15453.227338633249;15915.124668143364;16201.4329498467;16284.755728663842;16298;17531.474055778348;17724.93650380981;17971.37100201487;18081.638367232317;18287;15869.682606348038;16068.43760468378;16361;16381.542768584808;16391.09848958271;16023.919880400523;16220.026798392135;16244.918775406048;16293.918530407745;16295.59261018484;14775.482858099915;15833.366665333258;15901.204939752735;15936.840631594;15964.600884977968;11550.826737598774;11705.356205408785;11961.222520536137;12039.578614748441;12089.455974480994;10508.632197873038;11668.474918628512;12151.574694885636;12403.945664618608;12421.813672794735 12:50:29 INFO - PID 1644 | __end_tp_report 12:50:29 INFO - PID 1644 | __start_cc_report 12:50:29 INFO - PID 1644 | _x_x_mozilla_cycle_collect,2199 12:50:29 INFO - PID 1644 | __end_cc_report 12:50:29 INFO - PID 1644 | __startTimestamp1492285829593__endTimestamp 12:50:29 INFO - PID 1644 | 12:50:29 INFO - PID 1644 | ------- Summary: start ------- 12:50:29 INFO - PID 1644 | Number of tests: 6 12:50:29 INFO - PID 1644 | 12:50:29 INFO - PID 1644 | [#0] dojo.html Cycles:165 Average:6046.83 Median:6319.49 stddev:725.35 (11.5%) stddev-sans-first:698.95 12:50:29 INFO - PID 1644 | Values: 3475.1 3500.4 3501.8 3520.5 3561.6 5981.7 6108.1 6203.8 6247.9 6253.1 6080.8 6136.3 6136.4 6137.3 6144.7 5250.2 5261.2 5286.1 5301.8 5413.7 5375.5 5390.9 5395.8 5397.6 5403.7 4788.5 5041.9 5389.0 5392.7 5397.6 5391.5 5394.2 5394.6 5403.3 5412.5 5248.5 5332.0 5340.5 5348.4 5351.6 6260.9 6281.7 6290.0 6295.5 6295.9 6379.3 6531.8 6602.6 6604.9 6633.9 5446.3 5864.8 6528.1 6638.8 6718.4 6196.5 6313.7 6315.1 6319.5 6334.2 6849.6 6850.0 6852.2 6866.2 6888.5 6313.2 6400.0 6418.7 6439.8 6496.1 6572.5 6611.6 6679.6 6684.0 6685.8 6536.9 6539.5 6571.8 6572.9 6583.2 6323.9 6378.3 6620.9 6646.2 6663.8 4455.6 5342.1 5347.0 5355.4 5368.2 3917.3 4691.2 4691.9 4727.1 4729.7 6160.2 6198.2 6204.3 6211.2 6216.4 6374.1 6440.5 6476.0 6487.8 6502.8 6053.1 6104.8 6112.3 6124.7 6129.3 5713.5 5715.0 5717.1 5717.7 5723.5 6505.4 6553.1 6559.0 6573.9 6577.6 6432.1 6565.0 6659.9 6677.4 6688.3 6752.8 6771.2 6777.4 6780.9 6787.9 6503.3 6516.9 6519.3 6519.9 6532.0 6455.7 6539.2 6552.4 6553.4 6553.9 5224.7 6220.0 6334.9 6361.1 6380.6 6426.6 6445.2 6461.5 6465.4 6468.6 6350.0 6350.4 6354.1 6355.2 6360.9 6286.4 6371.5 6441.9 6460.5 6470.9 6009.9 6259.8 6268.1 6334.8 6358.5 12:50:29 INFO - PID 1644 | 12:50:29 INFO - PID 1644 | [#1] ext.html Cycles:180 Average:43579.26 Median:3150.03 stddev:73883.68 (2345.5%) stddev-sans-first:74021.12 12:50:29 INFO - PID 1644 | Values: 798.4 821.2 1120.0 1145.4 1147.1 34366.0 38032.0 38160.0 38355.2 38727.6 40134.4 40467.8 40480.0 40487.0 40538.4 6199.8 8693.4 8847.0 8864.5 8886.1 5267.8 7409.0 8661.7 8907.5 8908.9 8927.7 8979.5 8989.1 8990.8 8991.2 7444.4 8932.7 8938.2 8953.8 8956.3 7150.0 8567.0 8603.6 8655.8 8657.0 38358.6 38551.4 38570.4 38623.6 38628.6 3578.7 3623.1 3633.0 3638.3 3641.0 30394.8 30433.0 30470.0 30482.7 30510.7 3131.8 3168.2 3193.0 3203.3 3208.5 255834.7 261585.4 262236.0 262592.0 262610.0 40086.4 41090.8 49228.0 49514.0 49557.0 42908.8 51933.5 52403.7 52690.0 52792.5 14509.2 14631.8 14644.9 14648.1 14718.4 11896.9 11905.8 11916.9 11921.9 11923.0 13276.2 13292.0 13302.5 13336.5 13378.4 5680.5 5684.6 5720.6 5733.9 5737.6 879.7 1008.8 1023.0 1037.1 1068.1 23746.6 24606.6 24648.7 24721.1 24735.7 1007.7 1109.1 1129.7 1159.9 1170.6 11868.0 12078.2 12504.7 12541.0 12605.9 309441.0 309611.0 309627.0 310656.0 312289.0 55465.4 55532.0 55568.9 55624.7 55668.6 1270.7 1327.0 1521.9 1524.8 1541.1 23990.8 24047.4 24333.1 24380.3 24450.9 39360.8 39362.0 39366.8 39373.2 39695.4 272861.0 273385.0 273600.0 273643.0 273691.0 29325.3 30612.1 31029.0 35001.5 35817.8 42733.8 43640.6 43753.9 43851.0 43979.0 29545.3 29572.4 30265.9 30449.1 30773.7 27128.7 29761.0 30132.1 30397.0 30553.1 35681.1 36484.6 36549.1 36590.3 36650.8 29413.6 29699.4 30461.7 30564.0 30579.5 22829.1 23219.0 23499.1 23760.9 23974.4 12:50:29 INFO - PID 1644 | 12:50:29 INFO - PID 1644 | [#2] jquery.html Cycles:180 Average:34655.51 Median:22787.82 stddev:93008.03 (408.1%) stddev-sans-first:93233.35 12:50:29 INFO - PID 1644 | Values: 388.4 439.1 440.6 443.7 456.8 19139.8 21709.6 21959.8 23007.4 23324.9 22451.3 22774.1 22801.5 23080.2 23434.4 4852.5 6103.7 6139.7 6298.4 6368.7 5404.9 6189.9 6237.7 6297.8 6320.6 6092.8 6180.6 6201.2 6274.1 6275.9 6153.5 6177.9 6188.3 6256.8 6258.6 5495.8 5552.6 5556.7 5557.2 5569.6 22018.9 27135.3 27215.9 27383.0 27681.0 2221.6 2267.7 2267.8 2268.3 2274.3 17256.6 17786.4 18025.5 18029.9 18300.0 1820.6 2117.4 2179.1 2182.3 2196.3 123249.0 146816.3 147629.0 147712.0 149232.3 11101.2 11655.2 11663.5 12162.6 12233.2 14546.1 14909.6 14942.4 14948.6 14967.6 7383.5 8647.9 8821.9 8907.9 9026.4 8383.5 8405.8 8415.4 8599.7 8633.4 7561.7 7692.4 7735.5 7761.8 7770.7 1781.8 2106.7 2134.8 2137.5 2152.5 987.3 993.0 999.6 1039.5 1043.8 19605.0 20101.7 21023.8 21095.6 21180.8 981.2 1023.7 1025.4 1052.3 1059.4 10288.8 10552.0 10819.8 10854.5 11033.8 540600.0 549163.0 555813.0 557797.0 558952.0 86885.0 118293.2 118466.0 127476.0 133355.0 1169.7 1185.2 1241.5 1242.8 1243.9 17054.2 17189.7 22435.3 22560.5 22749.2 42328.6 42789.5 55543.9 55720.7 56091.7 76480.6 77565.6 77752.2 78032.0 79114.6 8612.2 8647.9 8783.8 8929.1 8955.7 11933.9 13231.7 13907.8 14044.5 14202.1 9378.5 9808.2 11853.7 11929.8 12116.4 8810.8 9266.4 10113.9 11056.4 11270.4 11712.3 11773.1 12007.9 12056.2 12071.9 8362.7 8384.8 8724.3 8840.0 8866.5 9560.4 10100.6 11511.1 11871.8 11927.2 12:50:29 INFO - PID 1644 | 12:50:29 INFO - PID 1644 | [#3] mootools.html Cycles:180 Average:7095.38 Median:3786.65 stddev:4553.06 (120.2%) stddev-sans-first:4544.47 12:50:29 INFO - PID 1644 | Values: 1226.2 1475.2 1494.1 1494.6 1496.6 11246.3 11730.0 11733.9 11740.6 11749.6 11242.1 11402.3 11676.1 11677.7 11677.7 2462.8 2508.6 2509.7 2515.5 2516.5 2110.1 2200.6 2420.3 2534.6 2540.4 2022.9 2184.0 2206.6 2533.9 2534.8 2493.0 2496.9 2496.9 2499.9 2503.8 2433.1 2475.4 2478.7 2479.7 2479.7 11613.2 11852.5 11859.9 11878.8 11891.7 6475.1 6729.8 6734.5 6741.7 6750.3 4062.5 4223.2 4352.5 4432.7 4449.9 1250.7 1254.7 1294.4 1296.6 1305.5 16486.7 16588.9 16601.1 16618.9 16653.6 5516.4 5549.9 5725.8 5824.9 5834.4 11199.2 11238.4 12321.0 12332.3 12333.4 6626.3 6630.5 6630.7 6644.4 6646.9 6152.3 6176.0 6177.0 6234.8 6272.4 4283.7 4411.3 4413.5 4477.3 4478.5 1276.2 1302.5 1303.7 1317.1 1320.1 748.5 769.6 770.8 770.9 772.6 5793.4 5820.7 6016.3 6045.5 6078.9 579.2 590.7 601.4 602.2 606.8 3608.7 3964.6 3986.6 4094.2 4114.2 14402.6 14746.3 15083.8 15274.5 15292.9 15012.1 15149.5 15318.0 15324.1 15338.8 8473.3 8650.5 8666.9 8673.1 8705.7 5850.6 5884.6 6241.2 6369.2 6467.8 13113.6 13306.5 13419.8 13452.7 13492.2 13823.0 13922.2 13956.6 13984.3 14154.4 8762.3 8774.3 8806.3 8873.8 8912.4 10627.8 10792.9 10798.4 10798.7 10810.6 8967.3 9205.8 9270.0 9332.8 9426.8 8880.2 8976.4 9057.3 9064.2 9065.3 7945.3 8166.1 8279.8 8279.8 8282.2 5981.6 6106.2 6110.5 6120.1 6179.6 6007.7 6062.5 6156.5 6237.9 6411.1 12:50:29 INFO - PID 1644 | 12:50:29 INFO - PID 1644 | [#4] prototype.html Cycles:180 Average:5080.51 Median:5639.18 stddev:1569.15 (27.8%) stddev-sans-first:1533.60 12:50:29 INFO - PID 1644 | Values: 392.8 396.2 399.0 405.7 421.5 5166.4 5701.4 6015.3 6055.3 6073.1 5728.0 5759.0 5863.6 5902.7 5942.3 3534.8 4577.9 4583.8 4599.4 4617.3 4370.3 4438.6 4561.5 4601.9 4612.6 4115.8 4512.5 4530.1 4546.7 4568.4 4510.5 4529.5 4543.1 4558.1 4559.1 3583.1 3772.8 4040.3 4059.4 4060.7 5568.7 5669.6 5703.3 5726.5 5785.2 5147.3 5155.7 5168.2 5170.3 5184.5 4679.4 5482.3 5931.9 5996.2 6307.4 4089.6 4299.4 4313.8 4317.9 4318.7 5674.8 6629.9 6704.2 6712.0 6723.8 4268.8 4352.4 4370.7 4378.2 4385.5 3676.8 4016.5 4162.2 4461.7 4463.8 5156.8 5180.1 5191.3 5196.6 5226.3 4985.5 5388.6 6030.6 6074.5 6382.3 1436.5 1462.2 1476.8 1508.3 1513.9 970.9 998.9 1009.8 1017.7 1017.9 4808.5 5003.7 5220.2 5882.3 5965.4 5981.8 6539.6 6548.0 6569.0 6587.8 5168.7 5345.3 5957.0 5961.9 5985.5 2538.9 3113.9 3378.4 3408.6 3413.7 6412.6 6557.6 6639.3 6675.9 6706.3 5201.7 5961.5 6630.0 6637.9 6725.7 6170.4 6633.8 6641.6 6652.9 6726.4 5608.7 6445.1 6471.7 6532.9 6542.9 5354.1 5994.3 6297.2 6489.6 6490.2 6481.2 6671.7 6675.4 6737.2 6759.4 3635.3 3840.7 4321.3 4356.4 4359.0 5104.1 5434.9 6582.4 6590.7 6627.5 5871.9 6033.4 6310.8 6326.5 6359.1 5758.4 6300.9 6304.0 6350.4 6524.4 5868.1 5918.4 6228.3 6233.2 6242.5 5558.9 5707.8 6044.8 6382.3 6399.4 5122.9 5911.6 6113.6 6213.0 6216.8 12:50:29 INFO - PID 1644 | 12:50:29 INFO - PID 1644 | [#5] yui.html Cycles:180 Average:21130.19 Median:17884.92 stddev:28833.05 (161.2%) stddev-sans-first:28873.21 12:50:29 INFO - PID 1644 | Values: 722.5 867.9 880.2 882.0 891.4 13225.4 18087.1 18773.9 18818.3 18838.4 16211.6 17590.5 17841.9 17884.2 17885.6 988.0 1002.8 1024.4 1024.4 1026.6 1030.8 1033.4 1033.9 1037.2 1037.3 1083.3 1087.1 1089.6 1091.0 1094.8 1078.1 1080.5 1083.0 1083.7 1083.9 801.1 804.2 806.1 807.6 807.9 15785.8 16825.9 17297.9 17376.2 17563.6 15814.7 15953.8 17477.7 17539.5 17551.5 13913.0 14025.2 14310.0 14419.1 14462.9 3562.0 3596.8 3604.3 3604.7 3611.6 111756.0 114014.0 116436.4 117250.4 117323.0 10379.6 11186.9 11342.7 13229.4 13802.7 20123.8 21095.6 24597.5 25291.4 25307.7 7952.7 8094.5 8097.6 8105.2 8105.5 4011.2 4021.6 4045.2 4091.0 4096.9 4354.5 4463.3 4469.7 4470.0 4473.0 925.5 961.6 965.6 971.5 972.1 632.3 651.5 660.7 661.7 686.3 11432.7 11941.1 12027.9 12029.0 12230.6 647.7 654.4 659.7 681.8 686.0 5105.2 5163.8 5172.1 5635.1 5644.8 91848.0 92944.0 94046.0 97462.0 98954.6 83345.2 84573.0 85038.0 85702.0 88750.6 45502.1 71549.0 77816.6 78526.6 80889.2 10423.4 10620.5 12082.1 12446.7 12503.3 39043.0 39589.0 40786.4 41130.0 42549.6 71174.6 71346.6 71691.6 72555.0 73127.0 15453.2 15915.1 16201.4 16284.8 16298.0 17531.5 17724.9 17971.4 18081.6 18287.0 15869.7 16068.4 16361.0 16381.5 16391.1 16023.9 16220.0 16244.9 16293.9 16295.6 14775.5 15833.4 15901.2 15936.8 15964.6 11550.8 11705.4 11961.2 12039.6 12089.5 10508.6 11668.5 12151.6 12403.9 12421.8 12:50:29 INFO - PID 1644 | -------- Summary: end -------- 12:50:29 INFO - PID 1644 | 12:50:30 INFO - TEST-INFO | 1644: exit 0 12:50:30 INFO - TEST-OK | dromaeo_css | took 1119398ms 12:50:30 INFO - TEST-START | kraken 12:50:30 INFO - operating with platform_type : mac_ 12:50:30 INFO - Initialising browser for kraken test... 12:50:30 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/tmpVjtGE2/profile http://localhost:49243/getInfo.html) 12:50:32 INFO - PID 1651 | __metrics Screen width/height:1600/1200 12:50:32 INFO - PID 1651 | colorDepth:24 12:50:32 INFO - PID 1651 | Browser inner width/height: 1024/689 12:50:32 INFO - PID 1651 | __metrics 12:50:32 INFO - PID 1651 | 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" 12:50:32 INFO - PID 1651 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:50:33 INFO - TEST-INFO | 1651: exit 0 12:50:33 INFO - Browser initialized. 12:50:33 INFO - Running cycle 1/1 for kraken test... 12:50:33 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/tmpVjtGE2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:50:45 INFO - PID 1652 | RSS: Main: 241782784 12:50:45 INFO - PID 1652 | 12:50:48 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 12:50:49 INFO - PID 1652 | RSS: Main: 311758848 12:50:49 INFO - PID 1652 | 12:50:52 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 12:50:53 INFO - PID 1652 | RSS: Main: 292786176 12:50:53 INFO - PID 1652 | 12:50:56 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 12:50:57 INFO - PID 1652 | RSS: Main: 384438272 12:50:57 INFO - PID 1652 | 12:50:59 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 12:50:59 INFO - PID 1652 | RSS: Main: 288333824 12:50:59 INFO - PID 1652 | 12:51:01 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:51:02 INFO - PID 1652 | RSS: Main: 290033664 12:51:02 INFO - PID 1652 | 12:51:05 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 12:51:05 INFO - PID 1652 | RSS: Main: 353562624 12:51:05 INFO - PID 1652 | 12:51:08 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 12:51:09 INFO - PID 1652 | RSS: Main: 370520064 12:51:09 INFO - PID 1652 | 12:51:12 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 12:51:12 INFO - PID 1652 | RSS: Main: 376586240 12:51:12 INFO - PID 1652 | 12:51:14 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:51:14 INFO - PID 1652 | RSS: Main: 333549568 12:51:14 INFO - PID 1652 | 12:51:16 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:51:17 INFO - PID 1652 | RSS: Main: 332320768 12:51:17 INFO - PID 1652 | 12:51:19 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:51:19 INFO - PID 1652 | RSS: Main: 335024128 12:51:19 INFO - PID 1652 | 12:51:22 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:51:23 INFO - PID 1652 | RSS: Main: 335175680 12:51:23 INFO - PID 1652 | 12:51:26 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:51:27 INFO - PID 1652 | RSS: Main: 344907776 12:51:27 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 12:51:29 INFO - PID 1652 | RSS: Main: 387608576 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | __start_tp_report 12:51:29 INFO - PID 1652 | _x_x_mozilla_page_load 12:51:29 INFO - PID 1652 | _x_x_mozilla_page_load_details 12:51:29 INFO - PID 1652 | |i|pagename|runs| 12:51:29 INFO - PID 1652 | |0;ai-astar;111;112;113;112;112;111;112;109;119;165 12:51:29 INFO - PID 1652 | |1;audio-beat-detection;143;111;110;154;137;105;147;142;159;108 12:51:29 INFO - PID 1652 | |2;audio-dft;196;263;192;186;184;185;187;180;185;184 12:51:29 INFO - PID 1652 | |3;audio-fft;82;57;59;88;63;79;65;61;81;58 12:51:29 INFO - PID 1652 | |4;audio-oscillator;88;71;84;69;68;70;90;67;69;91 12:51:29 INFO - PID 1652 | |5;imaging-gaussian-blur;87;87;86;87;87;86;86;86;87;87 12:51:29 INFO - PID 1652 | |6;imaging-darkroom;95;95;95;94;94;95;96;95;94;93 12:51:29 INFO - PID 1652 | |7;imaging-desaturate;87;83;85;84;84;84;86;85;105;138 12:51:29 INFO - PID 1652 | |8;json-parse-financial;50;50;48;49;49;51;51;52;51;51 12:51:29 INFO - PID 1652 | |9;json-stringify-tinderbox;56;57;58;58;70;59;57;57;57;57 12:51:29 INFO - PID 1652 | |10;stanford-crypto-aes;84;83;82;83;83;83;81;81;83;83 12:51:29 INFO - PID 1652 | |11;stanford-crypto-ccm;140;142;145;143;135;136;141;148;202;152 12:51:29 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;187;188;188;185;187;184;183;185;190;214 12:51:29 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;68;70;67;67;68;69;67;66;66;67 12:51:29 INFO - PID 1652 | __end_tp_report 12:51:29 INFO - PID 1652 | __start_cc_report 12:51:29 INFO - PID 1652 | _x_x_mozilla_cycle_collect,2160 12:51:29 INFO - PID 1652 | __end_cc_report 12:51:29 INFO - PID 1652 | __startTimestamp1492285889454__endTimestamp 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | ------- Summary: start ------- 12:51:29 INFO - PID 1652 | Number of tests: 14 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:117.60 Median:112.00 stddev:16.85 (15.0%) stddev-sans-first:17.71 12:51:29 INFO - PID 1652 | Values: 111.0 112.0 113.0 112.0 112.0 111.0 112.0 109.0 119.0 165.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:142.50 stddev:20.85 (14.6%) stddev-sans-first:21.70 12:51:29 INFO - PID 1652 | Values: 143.0 111.0 110.0 154.0 137.0 105.0 147.0 142.0 159.0 108.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:194.20 Median:186.50 stddev:24.58 (13.2%) stddev-sans-first:26.07 12:51:29 INFO - PID 1652 | Values: 196.0 263.0 192.0 186.0 184.0 185.0 187.0 180.0 185.0 184.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:69.30 Median:72.00 stddev:11.80 (16.4%) stddev-sans-first:11.59 12:51:29 INFO - PID 1652 | Values: 82.0 57.0 59.0 88.0 63.0 79.0 65.0 61.0 81.0 58.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:77.50 stddev:10.15 (13.1%) stddev-sans-first:9.91 12:51:29 INFO - PID 1652 | Values: 88.0 71.0 84.0 69.0 68.0 70.0 90.0 67.0 69.0 91.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 12:51:29 INFO - PID 1652 | Values: 87.0 87.0 86.0 87.0 87.0 86.0 86.0 86.0 87.0 87.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.84 (0.9%) stddev-sans-first:0.88 12:51:29 INFO - PID 1652 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 96.0 95.0 94.0 93.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:92.10 Median:84.50 stddev:17.37 (20.6%) stddev-sans-first:18.33 12:51:29 INFO - PID 1652 | Values: 87.0 83.0 85.0 84.0 84.0 84.0 86.0 85.0 105.0 138.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:51.00 stddev:1.23 (2.4%) stddev-sans-first:1.30 12:51:29 INFO - PID 1652 | Values: 50.0 50.0 48.0 49.0 49.0 51.0 51.0 52.0 51.0 51.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:57.50 stddev:4.09 (7.1%) stddev-sans-first:4.23 12:51:29 INFO - PID 1652 | Values: 56.0 57.0 58.0 58.0 70.0 59.0 57.0 57.0 57.0 57.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.97 (1.2%) stddev-sans-first:0.88 12:51:29 INFO - PID 1652 | Values: 84.0 83.0 82.0 83.0 83.0 83.0 81.0 81.0 83.0 83.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:144.00 stddev:19.51 (13.5%) stddev-sans-first:20.46 12:51:29 INFO - PID 1652 | Values: 140.0 142.0 145.0 143.0 135.0 136.0 141.0 148.0 202.0 152.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.10 Median:187.50 stddev:9.00 (4.8%) stddev-sans-first:9.51 12:51:29 INFO - PID 1652 | Values: 187.0 188.0 188.0 185.0 187.0 184.0 183.0 185.0 190.0 214.0 12:51:29 INFO - PID 1652 | 12:51:29 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.27 (1.9%) stddev-sans-first:1.33 12:51:29 INFO - PID 1652 | Values: 68.0 70.0 67.0 67.0 68.0 69.0 67.0 66.0 66.0 67.0 12:51:29 INFO - PID 1652 | -------- Summary: end -------- 12:51:29 INFO - PID 1652 | 12:51:30 INFO - TEST-INFO | 1652: exit 0 12:51:30 INFO - TEST-OK | kraken | took 60331ms 12:51:30 INFO - SUITE-END | took 1179s 12:51:31 INFO - Completed test suite (00:19:40) 12:51:31 INFO - javascript benchmark 12:51:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7756.797532357703, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3475.0617333320006, 3500.4049311617023, 3501.842417091231, 3520.489529018291, 3561.590417102034, 5981.671008094553, 6108.129596501685, 6203.844903877405, 6247.875042499148, 6253.09330147129, 6080.756769729205, 6136.325004249529, 6136.417040381168, 6137.324894261627, 6144.723487443064, 5250.238715386276, 5261.158214685651, 5286.074936886049, 5301.761420736076, 5413.675179489223, 5375.543078838284, 5390.9191362129595, 5395.838124856261, 5397.649152805075, 5403.729813509309, 4788.545088216614, 5041.890784027508, 5388.976094542044, 5392.703401312926, 5397.62216644835, 5391.514763671288, 5394.217838413408, 5394.622376433632, 5403.2705584746345, 5412.458754124556, 5248.475152484759, 5331.973340133274, 5340.519353258225, 5348.358197016383, 5351.598630102758, 6260.937390626126, 6281.685915704196, 6290.0, 6295.464885484739, 6295.874082518324, 6379.298277189506, 6531.823165498279, 6602.603843769341, 6604.867902641969, 6633.93366066338, 5446.346438427414, 5864.794732184396, 6528.08606795049, 6638.767643132467, 6718.428933540655, 6196.504279657616, 6313.747450101991, 6315.115883776275, 6319.494440444753, 6334.239891213084, 6849.554778939353, 6850.0, 6852.246252912176, 6866.244713081557, 6888.517803753689, 6313.2424109107205, 6400.0, 6418.679066046679, 6439.8068057958335, 6496.123023391876, 6572.539922205496, 6611.570247933869, 6679.599224046573, 6684.0, 6685.799426017227, 6536.901946470807, 6539.542232043711, 6571.83570410734, 6572.86854262912, 6583.210014798255, 6323.9051414228825, 6378.266499352541, 6620.933790662032, 6646.202455705346, 6663.833404164935, 4455.598996090367, 5342.065138600807, 5346.973265133727, 5355.3841308249275, 5368.1679339702405, 3917.275304068756, 4691.202495575761, 4691.906161876744, 4727.078219747116, 4729.69256998294, 6160.199174107427, 6198.2252218472695, 6204.317525072239, 6211.223597050369, 6216.44052035319, 6374.107624932513, 6440.4847612190915, 6475.996220585816, 6487.805365839033, 6502.837429064217, 6053.061775424816, 6104.786332478342, 6112.327643959161, 6124.693765311717, 6129.295131059896, 5713.485786279255, 5715.028445164332, 5717.056685646821, 5717.714114294268, 5723.456271654186, 6505.41451269388, 6553.115329430466, 6558.967205163944, 6573.901391479228, 6577.638229897401, 6432.09950606906, 6564.9671751642845, 6659.900101498384, 6677.432418244503, 6688.264290927897, 6752.763653272308, 6771.153605799275, 6777.356151165632, 6780.93219067803, 6787.932120678927, 6503.349665033648, 6516.934830651822, 6519.250286217146, 6519.902201466887, 6532.0, 6455.709493072917, 6539.247986481425, 6552.3775241352, 6553.4101930826455, 6553.868922621617, 5224.686518808731, 6219.968900155471, 6334.904976425265, 6361.141245931925, 6380.617162970237, 6426.582272152295, 6445.1943507061615, 6461.450776683847, 6465.3857883501, 6468.579542329733, 6349.952257877399, 6350.396712312323, 6354.110424540476, 6355.173827402593, 6360.918643830468, 6286.37136286386, 6371.522135839923, 6441.935580644321, 6460.45086167681, 6470.935290647033, 6009.879802404015, 6259.812205633838, 6268.091126786499, 6334.841628959313, 6358.491320694426], "value": 5997.880293740103, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.4490701416023, 821.2116368286443, 1119.9944000280002, 1145.4272863568217, 1147.1453766943628, 34365.969020929384, 38032.04919877008, 38160.0, 38355.23289534207, 38727.61272387275, 40134.39798403026, 40467.797661011726, 40480.0, 40487.0, 40538.39192412116, 6199.845003874917, 8693.434926729775, 8847.0, 8864.512451815148, 8886.111388861094, 5267.76295066721, 7409.0, 8661.740147795545, 8907.465552066897, 8908.8663670045, 8927.687530936419, 8979.461232326048, 8989.101089890992, 8990.775230619221, 8991.235744961687, 7444.441666874979, 8932.732018039469, 8938.1508756668, 8953.820923581558, 8956.328275379372, 7149.964250178716, 8567.0, 8603.569821508961, 8655.783605409852, 8657.0, 38358.616413835785, 38551.42172867409, 38570.421443678366, 38623.61376386228, 38628.61371386278, 3578.6600272974024, 3623.1304486923214, 3633.0, 3638.308721342963, 3641.0169254301454, 30394.84802575995, 30433.0, 30470.0, 30482.695173048207, 30510.694893051008, 3131.841218749055, 3168.2237851726245, 3193.0420873737785, 3203.2792621660174, 3208.454562724319, 255834.72082639468, 261585.384146158, 262236.0, 262592.0, 262610.0, 40086.39870401946, 41090.79454602708, 49228.0, 49514.0, 49557.0, 42908.78545607314, 51933.48066519287, 52403.73798131061, 52690.0, 52792.472075279526, 14509.201993890227, 14631.780523292158, 14644.853551464348, 14648.121112733057, 14718.411263549553, 11896.940515297369, 11905.761884762429, 11916.940415297868, 11921.940390298167, 11923.0, 13276.20342779417, 13292.003099767362, 13302.467901284033, 13336.466071446588, 13378.39797209128, 5680.466274105968, 5684.602077854511, 5720.597349113383, 5733.913991290134, 5737.5983681141915, 879.7272845417941, 1008.8335424654849, 1022.9846552301573, 1037.061459379248, 1068.076114161245, 23746.58090488296, 24606.62341012356, 24648.65724451867, 24721.128445397142, 24735.68721324542, 1007.7201953519136, 1109.134874797643, 1129.7119234595125, 1159.8840115988503, 1170.5961443302047, 11868.0, 12078.154529182873, 12504.749905001849, 12541.0, 12605.873941260654, 309441.0, 309611.0, 309627.0, 310656.0, 312289.0, 55465.44534554683, 55532.0, 55568.88862222733, 55624.721876391166, 55668.6082847924, 1270.7140893298933, 1326.9535566255329, 1521.9467318643794, 1524.809398825147, 1541.0907564536976, 23990.760092398854, 24047.398815029763, 24333.14833980802, 24380.26859194227, 24450.877745611157, 39360.80319598383, 39362.01594960149, 39366.83482408495, 39373.21253574855, 39695.40456893091, 272861.0, 273385.0, 273600.0, 273643.0, 273691.0, 29325.26686832846, 30612.08163755091, 31029.0, 35001.47497787586, 35817.77640012307, 42733.78633106814, 43640.56359436492, 43753.90615234645, 43851.0, 43979.0, 29545.2613684651, 29572.408551828412, 30265.940692076554, 30449.08652740421, 30773.692263077082, 27128.72871271341, 29761.0, 30132.11129556544, 30397.0, 30553.083407497812, 35681.1079723009, 36484.63515364812, 36549.08627284339, 36590.26819463649, 36650.8167459161, 29413.558796618498, 29699.406011880073, 30461.695383045884, 30564.0, 30579.54130688086, 22829.086836526352, 23219.0, 23499.060037598305, 23760.881195593913, 23974.40063998414], "value": 17438.192839044834, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.39399084784407, 439.117374078103, 440.5945035337274, 443.6694662476456, 456.808140580956, 19139.808601913977, 21709.565808683838, 21959.792211428365, 23007.42481437965, 23324.8833755831, 22451.32646020618, 22774.089036438523, 22801.54396912065, 23080.19219327324, 23434.414139646477, 4852.4662287148385, 6103.657195417001, 6139.72371243294, 6298.401651843067, 6368.74525019001, 5404.91892621611, 6189.938100619003, 6237.656928868911, 6297.811065668015, 6320.589161704497, 6092.786752463665, 6180.629162250257, 6201.193844800169, 6274.058891166316, 6275.905861412082, 6153.538484613627, 6177.876442471125, 6188.319284878659, 6256.812295631115, 6258.561900666955, 5495.807646732345, 5552.555795536347, 5556.749946252388, 5557.194206840026, 5569.637973531708, 22018.889905550368, 27135.321616959536, 27215.86392068027, 27383.04159354433, 27681.0, 2221.589006033889, 2267.7278726552754, 2267.7958983691547, 2268.3421807675754, 2274.3404412720292, 17256.56858578533, 17786.37747678838, 18025.459236222803, 18029.909850450797, 18300.0, 1820.6436205027208, 2117.4177101297114, 2179.1283486605485, 2182.3125715399597, 2196.2642514757576, 123249.0, 146816.2659186708, 147628.99999999892, 147712.0, 149232.2538387312, 11101.222914395914, 11655.242409243541, 11663.533458661728, 12162.635120946386, 12233.204841685261, 14546.054506457047, 14909.552713418614, 14942.402303907722, 14948.551543453714, 14967.625809354853, 7383.483156179123, 8647.870281945776, 8821.867671984925, 8907.910920890708, 9026.413283136575, 8383.542863955015, 8405.831883362298, 8415.368847336475, 8599.699010534601, 8633.352498562634, 7561.6597253122645, 7692.423023294195, 7735.458517903693, 7761.8447631047065, 7770.746483519716, 1781.8129096444686, 2106.6629339305637, 2134.8185404240503, 2137.540428807814, 2152.5479649273516, 987.3088837813559, 992.9702108936743, 999.5751805482786, 1039.4698703661036, 1043.7808060307268, 19605.019749012492, 20101.698474522895, 21023.78976210249, 21095.578088438146, 21180.835054071867, 981.1758123176566, 1023.7133602591286, 1025.4052649463292, 1052.315994603514, 1059.4067322299536, 10288.794224115476, 10551.997560231766, 10819.83770243447, 10854.511546980404, 11033.83449248262, 540600.0, 549163.0, 555813.0, 557797.0, 558952.0, 86885.0, 118293.22560161604, 118466.0, 127476.0, 133355.0, 1169.7309618787726, 1185.1822242652715, 1241.4847838147248, 1242.8384310039817, 1243.8569564500017, 17054.2325595346, 17189.742153867453, 22435.32694019182, 22560.548789024455, 22749.15635545557, 42328.57671423369, 42789.50236741699, 55543.88912221814, 55720.72139639276, 56091.71954140203, 76480.55837487215, 77565.61217193877, 77752.2224777745, 78032.0, 79114.6044269775, 8612.18184272493, 8647.870281945901, 8783.780405489913, 8929.06244844308, 8955.686550970684, 11933.925946664842, 13231.67683231669, 13907.791383129463, 14044.508442204473, 14202.147871127352, 9378.531073446436, 9808.185485685171, 11853.703657408289, 11929.82105268439, 12116.394180291127, 8810.75325791919, 9266.397684150508, 10113.89886101159, 11056.447177641247, 11270.380129092979, 11712.297262164297, 11773.117016223989, 12007.939960300142, 12056.216345937486, 12071.879281207426, 8362.707305244287, 8384.790380240544, 8724.302055835391, 8840.0, 8866.512341821262, 9560.378575392577, 10100.646477373257, 11511.136664750346, 11871.762564748484, 11927.165098443025], "value": 10239.15698859982, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1226.2274766896855, 1475.240251270595, 1494.1184701026393, 1494.559105064006, 1496.6034000989737, 11246.325220486766, 11730.00294974927, 11733.941330293357, 11740.589079382224, 11749.647510574685, 11242.100631949445, 11402.258853174539, 11676.065914726802, 11677.708057298572, 11677.708057298572, 2462.8276020678513, 2508.611165269386, 2509.6611957385794, 2515.4591762771, 2516.471540976397, 2110.0715685098585, 2200.5928903152967, 2420.334408037786, 2534.594464885619, 2540.428403609182, 2022.9393118206478, 2183.9890800545977, 2206.6248737714545, 2533.936651583707, 2534.7845433138114, 2493.0, 2496.8876400562017, 2496.9126080587275, 2499.862562534043, 2503.824732268742, 2433.0997530913496, 2475.405902583367, 2478.702555693328, 2479.652848601197, 2479.7148327942336, 11613.245139066019, 11852.525898964032, 11859.940700296444, 11878.762424751456, 11891.702707432298, 6475.093486911836, 6729.831754206135, 6734.528582999192, 6741.662916854187, 6750.291219421988, 4062.451569038172, 4223.176480586287, 4352.477702675699, 4432.734035957853, 4449.888752781174, 1250.67428525763, 1254.7239607286383, 1294.359292150382, 1296.5850927703138, 1305.5039085147582, 16486.67026659472, 16588.917055414644, 16601.086940218283, 16618.916905415517, 16653.583660408465, 5516.448355164452, 5549.916751248735, 5725.828225153252, 5824.88350232993, 5834.445727655951, 11199.160062995308, 11238.38188899602, 12321.0, 12332.260064395985, 12333.383330833602, 6626.304238055031, 6630.535862489676, 6630.701618427182, 6644.368784965421, 6646.900296495556, 6152.2924863640355, 6176.011838105882, 6177.0, 6234.844128896814, 6272.372762723691, 4283.657307415399, 4411.338299255073, 4413.536578659258, 4477.32840073985, 4478.507364189936, 1276.234259444326, 1302.5245785288303, 1303.69363199648, 1317.0583033131356, 1320.0825426328802, 748.4611080022376, 769.5959621198804, 770.8304173081913, 770.9014654117859, 772.6098320348301, 5793.391693872167, 5820.708964551755, 6016.338202797689, 6045.546584006217, 6078.908816367758, 579.1891352107084, 590.6574186971546, 601.3775742106899, 602.2321540036401, 606.7663949379521, 3608.6752192302292, 3964.623360780721, 3986.64120229175, 4094.160697057096, 4114.156597897424, 14402.639934001734, 14746.262686865613, 15083.773743393858, 15274.541763747106, 15292.923535382475, 15012.099274043592, 15149.469768558047, 15318.004329718533, 15324.080555166725, 15338.846611533965, 8473.322134229247, 8650.480971141626, 8666.913330866737, 8673.089325620846, 8705.695300664447, 5850.64896106235, 5884.617499862496, 6241.157443745218, 6369.235691716838, 6467.773627923, 13113.606591802261, 13306.46774129024, 13419.798703019658, 13452.730945381234, 13492.190468571916, 13823.032387732763, 13922.164670119826, 13956.581302560939, 13984.300784960507, 14154.363053662404, 8762.299016078827, 8774.34192435557, 8806.251468625238, 8873.778155545904, 8912.376133670581, 10627.787444250916, 10792.892071079188, 10798.40608766494, 10798.67603971882, 10810.621628242974, 8967.282617390723, 9205.815883682422, 9269.953650231706, 9332.766680833034, 9426.81146377055, 8880.200781929658, 8976.41653292534, 9057.275417966415, 9064.229540489132, 9065.32010099232, 7945.284924356604, 8166.142555031636, 8279.751607451786, 8279.793005174919, 8282.17178282167, 5981.611195272293, 6106.175666284995, 6110.541709371903, 6120.112583675431, 6179.62922224668, 6007.729652165751, 6062.484688801501, 6156.476699480594, 6237.937620623736, 6411.134496843053], "value": 5290.7338339014295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.8195771706023, 396.2471304521409, 398.96209860063294, 405.6511400195831, 421.4984168839079, 5166.380034395868, 5701.429857014296, 6015.278166620006, 6055.333913269542, 6073.117333626574, 5728.0, 5759.049756790135, 5863.560232982532, 5902.734376953037, 5942.2869255689375, 3534.8232588370606, 4577.901303687125, 4583.839565615204, 4599.413202445151, 4617.284320930261, 4370.322599997005, 4438.600525952664, 4561.498235194126, 4601.884952876171, 4612.630989520847, 4115.835366585333, 4512.45850497939, 4530.116627257686, 4546.749928753918, 4568.383268258793, 4510.526394728556, 4529.456465224194, 4543.137313701367, 4558.088382323532, 4559.133764584718, 3583.104223944014, 3772.8302226399605, 4040.272750904836, 4059.4316795648633, 4060.7157498975084, 5568.749406276727, 5669.603127781057, 5703.287089113861, 5726.513246374063, 5785.161151633031, 5147.330846989905, 5155.664881782672, 5168.22476628505, 5170.327857378555, 5184.455632158607, 4679.391679081732, 5482.342118945712, 5931.932252194603, 5996.194319447415, 6307.432331090178, 4089.6114869087387, 4299.398084268205, 4313.805878735433, 4317.948974237243, 4318.654507639413, 5674.801381951653, 6629.900551491732, 6704.228728983761, 6711.9664401678165, 6723.7646682365885, 4268.786560671954, 4352.412424322739, 4370.694051416434, 4378.190034843564, 4385.539518350527, 3676.7793932364143, 4016.457778199964, 4162.209180255742, 4461.665375096881, 4463.754493502824, 5156.845294641167, 5180.067587834226, 5191.325127733446, 5196.636235463557, 5226.3205783248695, 4985.451600323961, 5388.595855310868, 6030.5778595497895, 6074.542109893682, 6382.329855365213, 1436.5403071017383, 1462.232328027794, 1476.7637178051675, 1508.3212554350587, 1513.8940274180923, 970.8883478399933, 998.9200863930868, 1009.8333774927055, 1017.6641708236265, 1017.8982101789762, 4808.495108013678, 5003.699778013331, 5220.243064755589, 5882.323532793784, 5965.403459654087, 5981.825720751519, 6539.574927629689, 6547.967260163764, 6569.025739427673, 6587.769428069994, 5168.7415629218385, 5345.251664766935, 5957.0, 5961.850953726192, 5985.503624093976, 2538.9111381101943, 3113.8910138145056, 3378.35811195872, 3408.608010078823, 3413.7098346640814, 6412.583182093243, 6557.573757705733, 6639.302873198341, 6675.899861502081, 6706.317473010738, 5201.713905735145, 5961.485625796121, 6630.0, 6637.867242655217, 6725.730970761115, 6170.382961703794, 6633.834154146185, 6641.601503909781, 6652.8669426611195, 6726.3946244837225, 5608.747606357642, 6445.12990746262, 6471.676416179078, 6532.902006470002, 6542.855000375011, 5354.143337066051, 5994.280686317496, 6297.244330680348, 6489.643069631215, 6490.221173459215, 6481.152871431619, 6671.733130674913, 6675.4325882300545, 6737.191537015589, 6759.425448836904, 3635.345637785224, 3840.6543411093135, 4321.277595115057, 4356.4336636237085, 4359.04101097758, 5104.132297509506, 5434.864128396822, 6582.374674406115, 6590.736370545124, 6627.502937279627, 5871.94128058714, 6033.431307860076, 6310.842228944313, 6326.493880489457, 6359.109724638647, 5758.366579676316, 6300.936990630035, 6303.968480157753, 6350.396712312323, 6524.4454221389815, 5868.075670708605, 5918.378570250234, 6228.283747369111, 6233.2208473940755, 6242.500599952084, 5558.861028474321, 5707.771689132388, 6044.818655440344, 6382.32985536512, 6399.360063993563, 5122.8975420492125, 5911.645301281937, 6113.585133872007, 6213.0, 6216.813495595139], "value": 4599.749723945393, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.5050840174484, 867.8568036274015, 880.1858281089994, 881.963692661123, 891.3626756868839, 13225.404856781444, 18087.095645217752, 18773.906130469346, 18818.341358052436, 18838.43484695458, 16211.594710132253, 17590.472285831413, 17841.91079044603, 17884.195211215494, 17885.64228715425, 987.9802403951917, 1002.809466201423, 1024.3751311699893, 1024.4365598920601, 1026.6150193677372, 1030.7938412317528, 1033.405791669789, 1033.9276250662456, 1037.165082108902, 1037.3361048928691, 1083.3175099687187, 1087.1194332590626, 1089.5641743302704, 1091.0235339371259, 1094.7810437912449, 1078.0620859851979, 1080.529969463286, 1082.951267192978, 1083.6748975307455, 1083.9458027098653, 801.1187693537121, 804.2399932064202, 806.1495122645606, 807.64059993303, 807.9111297757242, 15785.763213551805, 16825.91587042057, 17297.91351043237, 17376.21807018687, 17563.5609109772, 15814.683706325925, 15953.760693589606, 17477.650446991116, 17539.473815785546, 17551.47345579622, 13913.026088173832, 14025.158490490603, 14310.0, 14419.062760920506, 14462.855371446256, 3562.0, 3596.7841929484316, 3604.297162053401, 3604.711623070148, 3611.6388361163936, 111756.0, 114014.0, 116436.41781791122, 117250.41374793071, 117323.0, 10379.636712715019, 11186.944065279622, 11342.716432089264, 13229.404676789567, 13802.723945521033, 20123.798762012193, 21095.578088438146, 24597.50804983926, 25291.367715807253, 25307.74692253054, 7952.681892724342, 8094.473859199134, 8097.635606397726, 8105.189481051965, 8105.513669179868, 4011.2178125265877, 4021.617946295097, 4045.19096180765, 4091.0, 4096.91806163881, 4354.455693038371, 4463.263561512379, 4469.709468884512, 4469.994251293433, 4473.0, 925.4771054354268, 961.5913236874301, 965.6089283839916, 971.5482300730054, 972.1493693018608, 632.2886752403546, 651.4755621724463, 660.6762686283687, 661.7319985405918, 686.3136863136863, 11432.714182145513, 11941.104417168746, 12027.939860300643, 12029.03767698582, 12230.571929982409, 647.6923461355818, 654.4437228355955, 659.7229163751236, 681.8329509270261, 686.0258433025017, 5105.183170692746, 5163.767630456563, 5172.120739474223, 5635.098384258499, 5644.774209031675, 91848.0, 92944.0, 94046.0, 97462.0, 98954.58885994628, 83345.16654833495, 84573.0, 85038.0, 85702.0, 88750.55624721835, 45502.08995820065, 71549.0, 77816.61091694619, 78526.6073669628, 80889.19110808935, 10423.374597524173, 10620.468976551296, 12082.100295929089, 12446.688832779253, 12503.312317822243, 39043.0, 39589.0, 40786.388204176365, 41129.97175070647, 42549.57450425456, 71174.57650847058, 71346.64326678333, 71691.64154179196, 72555.0, 73127.0, 15453.227338633249, 15915.124668143364, 16201.4329498467, 16284.755728663842, 16298.0, 17531.474055778348, 17724.93650380981, 17971.37100201487, 18081.638367232317, 18287.0, 15869.682606348038, 16068.43760468378, 16361.0, 16381.542768584808, 16391.09848958271, 16023.919880400523, 16220.026798392135, 16244.918775406048, 16293.918530407745, 16295.59261018484, 14775.482858099915, 15833.366665333258, 15901.204939752735, 15936.840631594, 15964.600884977968, 11550.826737598774, 11705.356205408785, 11961.222520536137, 12039.578614748441, 12089.455974480994, 10508.632197873038, 11668.474918628512, 12151.574694885636, 12403.945664618608, 12421.813672794735], "value": 8356.970897849335, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 113.0, 112.0, 112.0, 111.0, 112.0, 109.0, 119.0, 165.0], "value": 117.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 110.0, 154.0, 137.0, 105.0, 147.0, 142.0, 159.0, 108.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 263.0, 192.0, 186.0, 184.0, 185.0, 187.0, 180.0, 185.0, 184.0], "value": 194.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 57.0, 59.0, 88.0, 63.0, 79.0, 65.0, 61.0, 81.0, 58.0], "value": 69.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 84.0, 69.0, 68.0, 70.0, 90.0, 67.0, 69.0, 91.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 87.0, 87.0, 86.0, 86.0, 86.0, 87.0, 87.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 94.0, 93.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 85.0, 84.0, 84.0, 84.0, 86.0, 85.0, 105.0, 138.0], "value": 92.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 48.0, 49.0, 49.0, 51.0, 51.0, 52.0, 51.0, 51.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 58.0, 70.0, 59.0, 57.0, 57.0, 57.0, 57.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 83.0, 83.0, 83.0, 81.0, 81.0, 83.0, 83.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 145.0, 143.0, 135.0, 136.0, 141.0, 148.0, 202.0, 152.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 188.0, 188.0, 185.0, 187.0, 184.0, 183.0, 185.0, 190.0, 214.0], "value": 189.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 67.0, 68.0, 69.0, 67.0, 66.0, 66.0, 67.0], "value": 67.5, "unit": "score"}]}]} 12:51:31 INFO - Return code: 0 12:51:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:51:31 ERROR - # TBPL SUCCESS # 12:51:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:51:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:51:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:51:31 INFO - 2017-04-15 12:51:31.283 screenresolution[1657:11098] starting screenresolution argv=screenresolution get 12:51:31 INFO - 2017-04-15 12:51:31.285 screenresolution[1657:11098] Display 0: 1600x1200x32@60 12:51:31 INFO - 2017-04-15 12:51:31.291 screenresolution[1658:11101] starting screenresolution argv=screenresolution list 12:51:31 INFO - Available Modes on Display 0 12:51:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:51:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:51:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:51:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:51:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:51:31 INFO - Intel Iris: 12:51:31 INFO - Chipset Model: Intel Iris 12:51:31 INFO - Type: GPU 12:51:31 INFO - Bus: Built-In 12:51:31 INFO - VRAM (Dynamic, Max): 1536 MB 12:51:31 INFO - Vendor: Intel (0x8086) 12:51:31 INFO - Device ID: 0x0a2e 12:51:31 INFO - Revision ID: 0x0009 12:51:31 INFO - Displays: 12:51:31 INFO - Display: 12:51:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:51:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:51:31 INFO - Display Serial Number: 1600x1200 60 12:51:31 INFO - Main Display: Yes 12:51:31 INFO - Mirror: Off 12:51:31 INFO - Online: Yes 12:51:31 INFO - Rotation: Supported 12:51:31 INFO - Return code: 0 12:51:31 INFO - Running post-action listener: _resource_record_post_action 12:51:31 INFO - [mozharness: 2017-04-15 19:51:31.535047Z] Finished run-tests step (success) 12:51:31 INFO - Running post-run listener: _resource_record_post_run 12:51:31 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 31686144; Write bytes: 518461440; Read time: 315; Write time: 1774 12:51:31 INFO - TinderboxPrint: CPU usage
53.3% 12:51:31 INFO - TinderboxPrint: I/O read bytes / time
31,686,144 / 315 12:51:31 INFO - TinderboxPrint: I/O write bytes / time
518,461,440 / 1,774 12:51:31 INFO - TinderboxPrint: CPU idle
2,241.2 (46.7%) 12:51:31 INFO - TinderboxPrint: CPU system
954.1 (19.9%) 12:51:31 INFO - TinderboxPrint: CPU user
1,606.4 (33.5%) 12:51:31 INFO - TinderboxPrint: Swap in / out
236,032,000 / 0 12:51:31 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209551872; Write bytes: 213466624; Read time: 16163; Write time: 521 12:51:31 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 28990976; Write bytes: 303405568; Read time: 287; Write time: 1248 12:51:32 INFO - Running post-run listener: _upload_blobber_files 12:51:32 INFO - Blob upload gear active. 12:51:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:51:32 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 12:51:32 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'] 12:51:32 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 12:51:32 INFO - (blobuploader) - INFO - Open directory for files ... 12:51:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:51:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:51:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:33 INFO - (blobuploader) - INFO - Done attempting. 12:51:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:51:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:51:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:34 INFO - (blobuploader) - INFO - Done attempting. 12:51:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:51:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:51:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:35 INFO - (blobuploader) - INFO - Done attempting. 12:51:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:51:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:51:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:37 INFO - (blobuploader) - INFO - Done attempting. 12:51:37 INFO - (blobuploader) - INFO - Iteration through files over. 12:51:37 INFO - Return code: 0 12:51:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:51:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:51:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a04130a61f86e424637a8aa97c4128a938dfaace533ebbbc2823c28939c32ed4b3013d02e9f8dc6f6817f66819791151be622d3aaf99e9831a0443714f41fbf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b5f6b9cc04255fe8a7f51ac08207c79ec6a6a210a9ad4b5e97a5d0146d43c14821b1daf843554955db8d8ec1d5106732a62e452080ad6c5b35dd59d855c3f12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58f0d36078fdb03712632bb005922846aca11e027002aecff058394a43927b90f64476ce250b2778b70a7b097dd7cc0b6f565f1abdc20fb61b6d8caa79fb9f0a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/190668fe76220999f87c3cec2915ff119f1ec35ac5d0f414271146e8c251a6690b932992cd1c6f00e5cbf63c0ab714e01bb4f4c30d76e9eb146d41047a353ae6"} 12:51:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:51:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:51:37 INFO - Contents: 12:51:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a04130a61f86e424637a8aa97c4128a938dfaace533ebbbc2823c28939c32ed4b3013d02e9f8dc6f6817f66819791151be622d3aaf99e9831a0443714f41fbf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b5f6b9cc04255fe8a7f51ac08207c79ec6a6a210a9ad4b5e97a5d0146d43c14821b1daf843554955db8d8ec1d5106732a62e452080ad6c5b35dd59d855c3f12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58f0d36078fdb03712632bb005922846aca11e027002aecff058394a43927b90f64476ce250b2778b70a7b097dd7cc0b6f565f1abdc20fb61b6d8caa79fb9f0a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/190668fe76220999f87c3cec2915ff119f1ec35ac5d0f414271146e8c251a6690b932992cd1c6f00e5cbf63c0ab714e01bb4f4c30d76e9eb146d41047a353ae6"} 12:51:37 INFO - Running post-run listener: copy_logs_to_upload_dir 12:51:37 INFO - Copying logs to upload dir... 12:51:37 INFO - mkdir: /builds/slave/test/build/upload/logs 12:51:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.261933 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-15 12:51:37.188365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-15 12:51:37.191460) ========= 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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners TMPDIR=/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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/a04130a61f86e424637a8aa97c4128a938dfaace533ebbbc2823c28939c32ed4b3013d02e9f8dc6f6817f66819791151be622d3aaf99e9831a0443714f41fbf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b5f6b9cc04255fe8a7f51ac08207c79ec6a6a210a9ad4b5e97a5d0146d43c14821b1daf843554955db8d8ec1d5106732a62e452080ad6c5b35dd59d855c3f12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58f0d36078fdb03712632bb005922846aca11e027002aecff058394a43927b90f64476ce250b2778b70a7b097dd7cc0b6f565f1abdc20fb61b6d8caa79fb9f0a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/190668fe76220999f87c3cec2915ff119f1ec35ac5d0f414271146e8c251a6690b932992cd1c6f00e5cbf63c0ab714e01bb4f4c30d76e9eb146d41047a353ae6"} build_url:https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010607 build_url: 'https://queue.taskcluster.net/v1/task/ftlu35rQRwe-_2L247fcRw/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/a04130a61f86e424637a8aa97c4128a938dfaace533ebbbc2823c28939c32ed4b3013d02e9f8dc6f6817f66819791151be622d3aaf99e9831a0443714f41fbf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b5f6b9cc04255fe8a7f51ac08207c79ec6a6a210a9ad4b5e97a5d0146d43c14821b1daf843554955db8d8ec1d5106732a62e452080ad6c5b35dd59d855c3f12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58f0d36078fdb03712632bb005922846aca11e027002aecff058394a43927b90f64476ce250b2778b70a7b097dd7cc0b6f565f1abdc20fb61b6d8caa79fb9f0a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/190668fe76220999f87c3cec2915ff119f1ec35ac5d0f414271146e8c251a6690b932992cd1c6f00e5cbf63c0ab714e01bb4f4c30d76e9eb146d41047a353ae6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-15 12:51:37.225348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 12:51:37.225657) ========= 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.zsBm9qkEfc/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.i1eE3qZNoC/Listeners TMPDIR=/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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.005009 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 12:51:37.273877) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-15 12:51:37.274205) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-15 12:51:37.274521) ========= ========= Total master_lag: 0.20 =========