builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0243 starttime: 1492284290.9 results: success (0) buildid: 20170415105806 builduid: 2cd77f31bac445a9b759aefcc490df3d revision: ed88aa504601fc1a97ad83f8b4f3c17182a09425 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-15 12:24:50.903026) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-15 12:24:50.903507) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-15 12:24:50.903780) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-15 12:24:51.169747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 12:24:51.170313) ========= 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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:24:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2017-04-15 12:24:51 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.403066 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 12:24:51.598770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 12:24:51.599111) ========= 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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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.041701 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 12:24:51.662240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-15 12:24:51.662584) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ed88aa504601fc1a97ad83f8b4f3c17182a09425 --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 ed88aa504601fc1a97ad83f8b4f3c17182a09425 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:24:51,774 truncating revision to first 12 chars 2017-04-15 12:24:51,774 Setting DEBUG logging. 2017-04-15 12:24:51,774 attempt 1/10 2017-04-15 12:24:51,774 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ed88aa504601?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-15 12:24:52,954 unpacking tar archive at: mozilla-central-ed88aa504601/testing/mozharness/ program finished with exit code 0 elapsedTime=1.467309 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-15 12:24:53.167346) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-15 12:24:53.167657) ========= script_repo_revision: ed88aa504601fc1a97ad83f8b4f3c17182a09425 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-15 12:24:53.168019) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-15 12:24:53.171360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-15 12:24:53.195882) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-15 12:24:53.196800) ========= /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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:24:53 INFO - MultiFileLogger online at 20170415 12:24:53 in /builds/slave/test 12:24:53 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:24:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:24:53 INFO - {'append_to_log': False, 12:24:53 INFO - 'base_work_dir': '/builds/slave/test', 12:24:53 INFO - 'blob_upload_branch': 'Firefox', 12:24:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:24:53 INFO - 'branch': 'Firefox', 12:24:53 INFO - 'buildbot_json_path': 'buildprops.json', 12:24:53 INFO - 'config_files': ('talos/mac_config.py',), 12:24:53 INFO - 'default_actions': ('clobber', 12:24:53 INFO - 'read-buildbot-config', 12:24:53 INFO - 'download-and-extract', 12:24:53 INFO - 'populate-webroot', 12:24:53 INFO - 'create-virtualenv', 12:24:53 INFO - 'install', 12:24:53 INFO - 'run-tests'), 12:24:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:24:53 INFO - 'download_minidump_stackwalk': True, 12:24:53 INFO - 'download_symbols': 'ondemand', 12:24:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:24:53 INFO - 'tooltool.py': '/tools/tooltool.py', 12:24:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:24:53 INFO - '/tools/misc-python/virtualenv.py')}, 12:24:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:24:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:24:53 INFO - 'gecko_profile': False, 12:24:53 INFO - 'gecko_profile_interval': 0, 12:24:53 INFO - 'installer_path': 'installer.exe', 12:24:53 INFO - 'log_level': 'info', 12:24:53 INFO - 'log_name': 'talos', 12:24:53 INFO - 'log_to_console': True, 12:24:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:24:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:24:53 INFO - 'opt_config_files': (), 12:24:53 INFO - 'pip_index': False, 12:24:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:24:53 INFO - 'cmd': ('bash', 12:24:53 INFO - '-c', 12:24:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:24:53 INFO - 'enabled': True, 12:24:53 INFO - 'halt_on_failure': False, 12:24:53 INFO - 'name': 'check_screen_resolution'},), 12:24:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:24:53 INFO - 'cmd': ('bash', 12:24:53 INFO - '-c', 12:24:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:24:53 INFO - 'enabled': True, 12:24:53 INFO - 'halt_on_failure': False, 12:24:53 INFO - 'name': 'check_screen_resolution'},), 12:24:53 INFO - 'run_cmd_checks_enabled': True, 12:24:53 INFO - 'suite': 'dromaeojs', 12:24:53 INFO - 'system_bits': '32', 12:24:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:24:53 INFO - 'title': 't-yosemite-r7-0243', 12:24:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:24:53 INFO - 'use_talos_json': True, 12:24:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:24:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:24:53 INFO - 'work_dir': 'build'} 12:24:53 INFO - [mozharness: 2017-04-15 19:24:53.417923Z] Running clobber step. 12:24:53 INFO - Running pre-action listener: _resource_record_pre_action 12:24:53 INFO - Running main action method: clobber 12:24:53 INFO - rmtree: /builds/slave/test/build 12:24:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:24:55 INFO - Running post-action listener: _resource_record_post_action 12:24:55 INFO - [mozharness: 2017-04-15 19:24:55.997900Z] Finished clobber step (success) 12:24:55 INFO - [mozharness: 2017-04-15 19:24:55.998186Z] Running read-buildbot-config step. 12:24:55 INFO - Running pre-action listener: _resource_record_pre_action 12:24:55 INFO - Running main action method: read_buildbot_config 12:24:55 INFO - Using buildbot properties: 12:24:55 INFO - { 12:24:55 INFO - "project": "", 12:24:55 INFO - "product": "firefox", 12:24:56 INFO - "script_repo_revision": "production", 12:24:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 12:24:56 INFO - "repository": "", 12:24:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 12:24:56 INFO - "buildid": "20170415105806", 12:24:56 INFO - "pgo_build": "False", 12:24:56 INFO - "basedir": "/builds/slave/test", 12:24:56 INFO - "buildnumber": 9, 12:24:56 INFO - "slavename": "t-yosemite-r7-0243", 12:24:56 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:24:56 INFO - "platform": "yosemite_r7", 12:24:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:24:56 INFO - "branch": "mozilla-central", 12:24:56 INFO - "repo_path": "mozilla-central", 12:24:56 INFO - "revision": "ed88aa504601fc1a97ad83f8b4f3c17182a09425", 12:24:56 INFO - "stage_platform": "macosx64", 12:24:56 INFO - "builduid": "2cd77f31bac445a9b759aefcc490df3d", 12:24:56 INFO - "slavebuilddir": "test" 12:24:56 INFO - } 12:24:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 12:24:56 INFO - Running post-action listener: _resource_record_post_action 12:24:56 INFO - [mozharness: 2017-04-15 19:24:56.004112Z] Finished read-buildbot-config step (success) 12:24:56 INFO - [mozharness: 2017-04-15 19:24:56.004348Z] Running download-and-extract step. 12:24:56 INFO - Running pre-action listener: _resource_record_pre_action 12:24:56 INFO - Running main action method: download_and_extract 12:24:56 INFO - mkdir: /builds/slave/test/build/tests 12:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:56 INFO - trying https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 12:24:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/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:24:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/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:24:57 INFO - Downloaded 1325 bytes. 12:24:57 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:24:57 INFO - Using the following test package requirements: 12:24:57 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:24:57 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 12:24:57 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:24:57 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:24:57 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 12:24:57 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:24:57 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 12:24:57 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:24:57 INFO - u'jsshell-mac.zip'], 12:24:57 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:24:57 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 12:24:57 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:24:57 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:24:57 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 12:24:57 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:24:57 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 12:24:57 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:24:57 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 12:24:57 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:24:57 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 12:24:57 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:24:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:24:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:24:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:24:59 INFO - Expected file size: 52597072 12:24:59 INFO - Obtained file size: 52597072 12:25:15 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:25:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:25:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:25:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:25:17 INFO - Expected file size: 52597072 12:25:17 INFO - Obtained file size: 52597072 12:25:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 12:25:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:25:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 12:25:33 INFO - Expected file size: 14408853 12:25:33 INFO - Obtained file size: 14408853 12:25:33 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:25:33 INFO - trying https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:25:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 12:25:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/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:25:35 INFO - Downloaded 71108708 bytes. 12:25:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:25:35 INFO - mkdir: /builds/slave/test/properties 12:25:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:25:35 INFO - Writing to file /builds/slave/test/properties/build_url 12:25:35 INFO - Contents: 12:25:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:25:36 INFO - Running post-action listener: _resource_record_post_action 12:25:36 INFO - Running post-action listener: set_extra_try_arguments 12:25:36 INFO - [mozharness: 2017-04-15 19:25:36.565031Z] Finished download-and-extract step (success) 12:25:36 INFO - [mozharness: 2017-04-15 19:25:36.565186Z] Running populate-webroot step. 12:25:36 INFO - Running pre-action listener: _resource_record_pre_action 12:25:36 INFO - Running main action method: populate_webroot 12:25:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:25:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:25:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:25:36 INFO - '--tppagecycles', 12:25:36 INFO - '7'], 12:25:36 INFO - 'tests': ['tsvgm']}}, 12:25:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:25:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:25:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:25:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:25:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:25:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:25:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:25:36 INFO - 'talos_options': ['--disable-e10s'], 12:25:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:25:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:25:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:25:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:25:36 INFO - 'talos_options': ['--disable-e10s'], 12:25:36 INFO - 'tests': ['damp', 'tps']}, 12:25:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:25:36 INFO - 'tests': ['damp', 'tps']}, 12:25:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:25:36 INFO - 'tests': ['dromaeo_dom']}, 12:25:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:25:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:25:36 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:25:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:25:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:25:36 INFO - 'tests': ['a11yr', 12:25:36 INFO - 'ts_paint', 12:25:36 INFO - 'tpaint', 12:25:36 INFO - 'sessionrestore', 12:25:36 INFO - 'sessionrestore_no_auto_restore', 12:25:36 INFO - 'tabpaint']}, 12:25:36 INFO - 'other-e10s': {'tests': ['a11yr', 12:25:36 INFO - 'ts_paint', 12:25:36 INFO - 'tpaint', 12:25:36 INFO - 'sessionrestore', 12:25:36 INFO - 'sessionrestore_no_auto_restore', 12:25:36 INFO - 'tabpaint']}, 12:25:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:25:36 INFO - 'ts_paint', 12:25:36 INFO - 'tpaint', 12:25:36 INFO - 'sessionrestore', 12:25:36 INFO - 'sessionrestore_no_auto_restore', 12:25:36 INFO - 'tabpaint']}, 12:25:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:25:36 INFO - 'ts_paint', 12:25:36 INFO - 'tpaint', 12:25:36 INFO - 'sessionrestore', 12:25:36 INFO - 'sessionrestore_no_auto_restore', 12:25:36 INFO - 'tabpaint']}, 12:25:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:25:36 INFO - 'tests': ['a11yr', 12:25:36 INFO - 'ts_paint', 12:25:36 INFO - 'tpaint', 12:25:36 INFO - 'sessionrestore', 12:25:36 INFO - 'sessionrestore_no_auto_restore', 12:25:36 INFO - 'tabpaint']}, 12:25:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:25:36 INFO - 'tests': ['a11yr', 12:25:36 INFO - 'ts_paint', 12:25:36 INFO - 'tpaint', 12:25:36 INFO - 'sessionrestore', 12:25:36 INFO - 'sessionrestore_no_auto_restore', 12:25:36 INFO - 'tabpaint']}, 12:25:36 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 12:25:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 12:25:36 INFO - 'bloom_basic_ref']}, 12:25:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:25:36 INFO - 'tests': ['tsvgx', 12:25:36 INFO - 'tsvgr_opacity', 12:25:36 INFO - 'tart', 12:25:36 INFO - 'tscrollx', 12:25:36 INFO - 'cart', 12:25:36 INFO - 'tsvg_static']}, 12:25:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:25:36 INFO - 'tsvgr_opacity', 12:25:36 INFO - 'tart', 12:25:36 INFO - 'tscrollx', 12:25:36 INFO - 'cart', 12:25:36 INFO - 'tsvg_static']}, 12:25:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:25:36 INFO - 'talos_options': ['--disable-e10s'], 12:25:36 INFO - 'tests': ['tp5o']}, 12:25:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:25:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:25:36 INFO - 'talos_options': ['--disable-e10s', 12:25:36 INFO - '--xperf_path', 12:25:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:25:36 INFO - 'tests': ['tp5n']}, 12:25:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:25:36 INFO - 'talos_options': ['--xperf_path', 12:25:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:25:36 INFO - 'tests': ['tp5n']}}, 12:25:36 INFO - 'talos.zip': {'path': '', 12:25:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:25:36 INFO - Running post-action listener: _resource_record_post_action 12:25:36 INFO - [mozharness: 2017-04-15 19:25:36.584053Z] Finished populate-webroot step (success) 12:25:36 INFO - [mozharness: 2017-04-15 19:25:36.584186Z] Running create-virtualenv step. 12:25:36 INFO - Running pre-action listener: _resource_record_pre_action 12:25:36 INFO - Running main action method: create_virtualenv 12:25:36 INFO - Creating virtualenv /builds/slave/test/build/venv 12:25:36 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:25:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:25:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:25:36 INFO - Using real prefix '/tools/python27' 12:25:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:25:37 INFO - Installing distribute.............................................................................................................................................................................................done. 12:25:40 INFO - Installing pip.................done. 12:25:40 INFO - Return code: 0 12:25:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:25:40 INFO - Reading from file tmpfile_stdout 12:25:40 INFO - Output received: 12:25:40 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:25:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:25:40 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:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:40 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:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:40 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 0x108706b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108709768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a6848dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e4d30>, '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 0x10840adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084d9be8>, '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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:25:40 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:25:40 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:25:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vzSSEiJ2x1/Render', 12:25:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:25:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:25:40 INFO - 'HOME': '/Users/cltbld', 12:25:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:25:40 INFO - 'LOGNAME': 'cltbld', 12:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:40 INFO - 'MOZ_NO_REMOTE': '1', 12:25:40 INFO - 'NO_EM_RESTART': '1', 12:25:40 INFO - 'PAGER': '/bin/cat', 12:25:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:40 INFO - 'PWD': '/builds/slave/test', 12:25:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:25:40 INFO - 'SHELL': '/bin/bash', 12:25:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MZUC8bIoSU/Listeners', 12:25:40 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 12:25:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:25:40 INFO - 'USER': 'cltbld', 12:25:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:25:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:40 INFO - 'XPC_FLAGS': '0x0', 12:25:40 INFO - 'XPC_SERVICE_NAME': '0', 12:25:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:40 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:25:40 INFO - Cleaning up... 12:25:40 INFO - Return code: 0 12:25:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:25:40 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:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:40 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:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:40 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 0x108706b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108709768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a6848dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e4d30>, '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 0x10840adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084d9be8>, '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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:25:40 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:25:40 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:25:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vzSSEiJ2x1/Render', 12:25:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:25:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:25:40 INFO - 'HOME': '/Users/cltbld', 12:25:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:25:40 INFO - 'LOGNAME': 'cltbld', 12:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:40 INFO - 'MOZ_NO_REMOTE': '1', 12:25:40 INFO - 'NO_EM_RESTART': '1', 12:25:40 INFO - 'PAGER': '/bin/cat', 12:25:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:40 INFO - 'PWD': '/builds/slave/test', 12:25:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:25:40 INFO - 'SHELL': '/bin/bash', 12:25:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MZUC8bIoSU/Listeners', 12:25:40 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 12:25:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:25:40 INFO - 'USER': 'cltbld', 12:25:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:25:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:40 INFO - 'XPC_FLAGS': '0x0', 12:25:40 INFO - 'XPC_SERVICE_NAME': '0', 12:25:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:41 INFO - Downloading/unpacking psutil>=3.1.1 12:25:41 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:25:41 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:25:41 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:25:41 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:25:41 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:25:41 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:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:25:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:25:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:25:44 INFO - Installing collected packages: psutil 12:25:44 INFO - Running setup.py install for psutil 12:25:44 INFO - building 'psutil._psutil_osx' extension 12:25:44 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:25:45 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:25:45 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:25:45 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:25:45 INFO - building 'psutil._psutil_posix' extension 12:25:45 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:25:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:25:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:25:45 INFO - ^ 12:25:45 INFO - 1 warning generated. 12:25:45 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:25:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:25:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:25:46 INFO - Successfully installed psutil 12:25:46 INFO - Cleaning up... 12:25:46 INFO - Return code: 0 12:25:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108706b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108709768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a6848dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e4d30>, '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 0x10840adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084d9be8>, '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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:25:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vzSSEiJ2x1/Render', 12:25:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:25:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:25:46 INFO - 'HOME': '/Users/cltbld', 12:25:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:25:46 INFO - 'LOGNAME': 'cltbld', 12:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:46 INFO - 'MOZ_NO_REMOTE': '1', 12:25:46 INFO - 'NO_EM_RESTART': '1', 12:25:46 INFO - 'PAGER': '/bin/cat', 12:25:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:46 INFO - 'PWD': '/builds/slave/test', 12:25:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:25:46 INFO - 'SHELL': '/bin/bash', 12:25:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MZUC8bIoSU/Listeners', 12:25:46 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 12:25:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:25:46 INFO - 'USER': 'cltbld', 12:25:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:25:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:46 INFO - 'XPC_FLAGS': '0x0', 12:25:46 INFO - 'XPC_SERVICE_NAME': '0', 12:25:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:25:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:25:49 INFO - Installing collected packages: mozsystemmonitor 12:25:49 INFO - Running setup.py install for mozsystemmonitor 12:25:49 INFO - Successfully installed mozsystemmonitor 12:25:49 INFO - Cleaning up... 12:25:49 INFO - Return code: 0 12:25:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108706b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108709768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a6848dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e4d30>, '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 0x10840adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084d9be8>, '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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:25:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vzSSEiJ2x1/Render', 12:25:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:25:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:25:49 INFO - 'HOME': '/Users/cltbld', 12:25:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:25:49 INFO - 'LOGNAME': 'cltbld', 12:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:49 INFO - 'MOZ_NO_REMOTE': '1', 12:25:49 INFO - 'NO_EM_RESTART': '1', 12:25:49 INFO - 'PAGER': '/bin/cat', 12:25:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:49 INFO - 'PWD': '/builds/slave/test', 12:25:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:25:49 INFO - 'SHELL': '/bin/bash', 12:25:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MZUC8bIoSU/Listeners', 12:25:49 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 12:25:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:25:49 INFO - 'USER': 'cltbld', 12:25:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:25:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:49 INFO - 'XPC_FLAGS': '0x0', 12:25:49 INFO - 'XPC_SERVICE_NAME': '0', 12:25:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:49 INFO - Downloading/unpacking jsonschema==2.5.1 12:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:25:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:25:52 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:25:52 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:25:52 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:25:52 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:25:52 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:25:52 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:25:52 INFO - Downloading functools32-3.2.3-2.tar.gz 12:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:25:52 INFO - warning: no files found matching '*.txt' 12:25:52 INFO - no previously-included directories found matching 'build' 12:25:52 INFO - no previously-included directories found matching 'dist' 12:25:52 INFO - no previously-included directories found matching '.git*' 12:25:52 INFO - Installing collected packages: jsonschema, functools32 12:25:52 INFO - Running setup.py install for functools32 12:25:52 INFO - warning: no files found matching '*.txt' 12:25:52 INFO - no previously-included directories found matching 'build' 12:25:52 INFO - no previously-included directories found matching 'dist' 12:25:52 INFO - no previously-included directories found matching '.git*' 12:25:52 INFO - Successfully installed jsonschema functools32 12:25:52 INFO - Cleaning up... 12:25:52 INFO - Return code: 0 12:25:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:52 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 0x108706b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108709768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a6848dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e4d30>, '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 0x10840adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084d9be8>, '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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:25:52 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:25:52 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:25:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vzSSEiJ2x1/Render', 12:25:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:25:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:25:52 INFO - 'HOME': '/Users/cltbld', 12:25:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:25:52 INFO - 'LOGNAME': 'cltbld', 12:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:52 INFO - 'MOZ_NO_REMOTE': '1', 12:25:52 INFO - 'NO_EM_RESTART': '1', 12:25:52 INFO - 'PAGER': '/bin/cat', 12:25:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:52 INFO - 'PWD': '/builds/slave/test', 12:25:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:25:52 INFO - 'SHELL': '/bin/bash', 12:25:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MZUC8bIoSU/Listeners', 12:25:52 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 12:25:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:25:52 INFO - 'USER': 'cltbld', 12:25:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:25:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:52 INFO - 'XPC_FLAGS': '0x0', 12:25:52 INFO - 'XPC_SERVICE_NAME': '0', 12:25:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:25:53 INFO - Cleaning up... 12:25:53 INFO - Return code: 0 12:25:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:53 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 0x108706b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108709768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a6848dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e4d30>, '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 0x10840adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084d9be8>, '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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:25:53 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:25:53 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:25:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vzSSEiJ2x1/Render', 12:25:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:25:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:25:53 INFO - 'HOME': '/Users/cltbld', 12:25:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:25:53 INFO - 'LOGNAME': 'cltbld', 12:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:53 INFO - 'MOZ_NO_REMOTE': '1', 12:25:53 INFO - 'NO_EM_RESTART': '1', 12:25:53 INFO - 'PAGER': '/bin/cat', 12:25:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:53 INFO - 'PWD': '/builds/slave/test', 12:25:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:25:53 INFO - 'SHELL': '/bin/bash', 12:25:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MZUC8bIoSU/Listeners', 12:25:53 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 12:25:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:25:53 INFO - 'USER': 'cltbld', 12:25:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:25:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:53 INFO - 'XPC_FLAGS': '0x0', 12:25:53 INFO - 'XPC_SERVICE_NAME': '0', 12:25:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:53 INFO - Downloading/unpacking blobuploader==1.2.4 12:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:56 INFO - Downloading blobuploader-1.2.4.tar.gz 12:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:25:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:25:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:57 INFO - Downloading docopt-0.6.1.tar.gz 12:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:25:57 INFO - Installing collected packages: blobuploader, requests, docopt 12:25:57 INFO - Running setup.py install for blobuploader 12:25:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:25:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:25:57 INFO - Running setup.py install for requests 12:25:58 INFO - Running setup.py install for docopt 12:25:58 INFO - Successfully installed blobuploader requests docopt 12:25:58 INFO - Cleaning up... 12:25:58 INFO - Return code: 0 12:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:58 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 0x108706b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108709768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a6848dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e4d30>, '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 0x10840adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084d9be8>, '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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:25:58 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:25:58 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:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vzSSEiJ2x1/Render', 12:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:25:58 INFO - 'HOME': '/Users/cltbld', 12:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:25:58 INFO - 'LOGNAME': 'cltbld', 12:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:58 INFO - 'MOZ_NO_REMOTE': '1', 12:25:58 INFO - 'NO_EM_RESTART': '1', 12:25:58 INFO - 'PAGER': '/bin/cat', 12:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:58 INFO - 'PWD': '/builds/slave/test', 12:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:25:58 INFO - 'SHELL': '/bin/bash', 12:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MZUC8bIoSU/Listeners', 12:25:58 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 12:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:25:58 INFO - 'USER': 'cltbld', 12:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:58 INFO - 'XPC_FLAGS': '0x0', 12:25:58 INFO - 'XPC_SERVICE_NAME': '0', 12:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:25:58 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-tIaRZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:25:58 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-UeDxhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:25:58 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-uekC2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:25:58 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-tKVQEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:25:59 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-b_tJaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:25:59 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-jjwuNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:25:59 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-jHRNTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:25:59 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-QTXfNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:25:59 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-ahgjKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:25:59 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-VSFcyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:25:59 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-uporFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:25:59 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-IoWtpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:25:59 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-3PdSpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:25:59 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-c3vUGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:00 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-3mIggU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:26:00 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-t__tSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:26:00 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-DhFmSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:26:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:26:00 INFO - Running setup.py install for manifestparser 12:26:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:26:00 INFO - Running setup.py install for mozcrash 12:26:00 INFO - Running setup.py install for mozdebug 12:26:00 INFO - Running setup.py install for mozdevice 12:26:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:26:00 INFO - Running setup.py install for mozfile 12:26:01 INFO - Running setup.py install for mozhttpd 12:26:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:26:01 INFO - Running setup.py install for mozinfo 12:26:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:26:01 INFO - Running setup.py install for mozInstall 12:26:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:26:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:26:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:26:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:26:01 INFO - Running setup.py install for mozleak 12:26:01 INFO - Running setup.py install for mozlog 12:26:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:26:01 INFO - Running setup.py install for moznetwork 12:26:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:26:01 INFO - Running setup.py install for mozprocess 12:26:02 INFO - Running setup.py install for mozprofile 12:26:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Running setup.py install for mozrunner 12:26:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Running setup.py install for mozscreenshot 12:26:02 INFO - Running setup.py install for moztest 12:26:02 INFO - Running setup.py install for mozversion 12:26:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:26:02 INFO - Cleaning up... 12:26:02 INFO - Return code: 0 12:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26: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:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26: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:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:02 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 0x108706b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108709768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a6848dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e4d30>, '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 0x10840adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084d9be8>, '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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:26:02 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:26:02 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:26:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vzSSEiJ2x1/Render', 12:26:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:02 INFO - 'HOME': '/Users/cltbld', 12:26:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:02 INFO - 'LOGNAME': 'cltbld', 12:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:02 INFO - 'MOZ_NO_REMOTE': '1', 12:26:02 INFO - 'NO_EM_RESTART': '1', 12:26:02 INFO - 'PAGER': '/bin/cat', 12:26:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:02 INFO - 'PWD': '/builds/slave/test', 12:26:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:02 INFO - 'SHELL': '/bin/bash', 12:26:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MZUC8bIoSU/Listeners', 12:26:02 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 12:26:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:02 INFO - 'USER': 'cltbld', 12:26:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:02 INFO - 'XPC_FLAGS': '0x0', 12:26:02 INFO - 'XPC_SERVICE_NAME': '0', 12:26:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:26:03 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-pf0NSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:26:03 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:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:26:03 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-uUJj6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:26:03 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:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:26:03 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-aUKz_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:26:03 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:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:26:03 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-PDKrTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:26:03 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:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:26:03 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-GeQ1LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:26:03 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:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:26:03 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-kih5Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:26:03 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:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:26:03 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-tYWQT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:26:03 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:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:26:03 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-wivxEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:26:04 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:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:26:04 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-N4V02X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:26:04 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:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:26:04 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-TlOm1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:26:04 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:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:26:04 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-i2Vgmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:26:04 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:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:26:04 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-sDTmKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:26:04 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:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:26:04 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-HUzH8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:26:04 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:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:26:04 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-aUClFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:26:04 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:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:04 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-ggxYF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:04 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:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:26:04 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-qLN9Nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:26:04 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:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:26:04 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-ACeNS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:26:04 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:26:04 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:26:04 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:26:04 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:26:04 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:26:04 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:26:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:05 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:26:05 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:26:07 INFO - Downloading blessings-1.6.tar.gz 12:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:26:07 INFO - Installing collected packages: blessings 12:26:07 INFO - Running setup.py install for blessings 12:26:07 INFO - Successfully installed blessings 12:26:07 INFO - Cleaning up... 12:26:08 INFO - Return code: 0 12:26:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:26:08 INFO - Reading from file tmpfile_stdout 12:26:08 INFO - Current package versions: 12:26:08 INFO - blessings == 1.6 12:26:08 INFO - blobuploader == 1.2.4 12:26:08 INFO - docopt == 0.6.1 12:26:08 INFO - functools32 == 3.2.3-2 12:26:08 INFO - jsonschema == 2.5.1 12:26:08 INFO - manifestparser == 1.1 12:26:08 INFO - mozInstall == 1.12 12:26:08 INFO - mozcrash == 1.0 12:26:08 INFO - mozdebug == 0.1 12:26:08 INFO - mozdevice == 0.50 12:26:08 INFO - mozfile == 1.2 12:26:08 INFO - mozhttpd == 0.7 12:26:08 INFO - mozinfo == 0.9 12:26:08 INFO - mozleak == 0.1 12:26:08 INFO - mozlog == 3.4 12:26:08 INFO - moznetwork == 0.27 12:26:08 INFO - mozprocess == 0.25 12:26:08 INFO - mozprofile == 0.28 12:26:08 INFO - mozrunner == 6.13 12:26:08 INFO - mozscreenshot == 0.1 12:26:08 INFO - mozsystemmonitor == 0.3 12:26:08 INFO - moztest == 0.8 12:26:08 INFO - mozversion == 1.4 12:26:08 INFO - psutil == 3.1.1 12:26:08 INFO - requests == 1.2.3 12:26:08 INFO - wsgiref == 0.1.2 12:26:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:08 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 0x108706b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108709768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a6848dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e4d30>, '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 0x10840adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084d9be8>, '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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:26:08 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:26:08 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:26:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vzSSEiJ2x1/Render', 12:26:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:08 INFO - 'HOME': '/Users/cltbld', 12:26:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:08 INFO - 'LOGNAME': 'cltbld', 12:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:08 INFO - 'MOZ_NO_REMOTE': '1', 12:26:08 INFO - 'NO_EM_RESTART': '1', 12:26:08 INFO - 'PAGER': '/bin/cat', 12:26:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:08 INFO - 'PWD': '/builds/slave/test', 12:26:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:08 INFO - 'SHELL': '/bin/bash', 12:26:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MZUC8bIoSU/Listeners', 12:26:08 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 12:26:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:08 INFO - 'USER': 'cltbld', 12:26:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:08 INFO - 'XPC_FLAGS': '0x0', 12:26:08 INFO - 'XPC_SERVICE_NAME': '0', 12:26:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:08 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:26:08 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:26:08 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:26:08 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:26:08 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:26:08 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:26:08 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:26:08 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:26:08 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:26:08 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:26:08 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:26:08 INFO - Cleaning up... 12:26:08 INFO - Return code: 0 12:26:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108706b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108709768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a6848dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e4d30>, '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 0x10840adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084d9be8>, '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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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:26:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:26:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vzSSEiJ2x1/Render', 12:26:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:08 INFO - 'HOME': '/Users/cltbld', 12:26:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:08 INFO - 'LOGNAME': 'cltbld', 12:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:08 INFO - 'MOZ_NO_REMOTE': '1', 12:26:08 INFO - 'NO_EM_RESTART': '1', 12:26:08 INFO - 'PAGER': '/bin/cat', 12:26:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:08 INFO - 'PWD': '/builds/slave/test', 12:26:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:08 INFO - 'SHELL': '/bin/bash', 12:26:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MZUC8bIoSU/Listeners', 12:26:08 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 12:26:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:08 INFO - 'USER': 'cltbld', 12:26:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:08 INFO - 'XPC_FLAGS': '0x0', 12:26:08 INFO - 'XPC_SERVICE_NAME': '0', 12:26:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:26:08 INFO - Cleaning up... 12:26:08 INFO - Return code: 0 12:26:08 INFO - Running post-action listener: _resource_record_post_action 12:26:08 INFO - Running post-action listener: _start_resource_monitoring 12:26:08 INFO - Starting resource monitoring. 12:26:08 INFO - [mozharness: 2017-04-15 19:26:08.863928Z] Finished create-virtualenv step (success) 12:26:08 INFO - [mozharness: 2017-04-15 19:26:08.864925Z] Running install step. 12:26:08 INFO - Running pre-action listener: _resource_record_pre_action 12:26:08 INFO - Running main action method: install 12:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:26:09 INFO - Reading from file tmpfile_stdout 12:26:09 INFO - Detecting whether we're running mozinstall >=1.0... 12:26:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:26:09 INFO - Reading from file tmpfile_stdout 12:26:09 INFO - Output received: 12:26:09 INFO - Usage: mozinstall [options] installer 12:26:09 INFO - Options: 12:26:09 INFO - -h, --help show this help message and exit 12:26:09 INFO - -d DEST, --destination=DEST 12:26:09 INFO - Directory to install application into. [default: 12:26:09 INFO - "/builds/slave/test"] 12:26:09 INFO - --app=APP Application being installed. [default: firefox] 12:26:09 INFO - mkdir: /builds/slave/test/build/application 12:26:09 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:26:09 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:26:29 INFO - Reading from file tmpfile_stdout 12:26:29 INFO - Output received: 12:26:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:26:29 INFO - Running post-action listener: _resource_record_post_action 12:26:29 INFO - [mozharness: 2017-04-15 19:26:29.016991Z] Finished install step (success) 12:26:29 INFO - [mozharness: 2017-04-15 19:26:29.017127Z] Running run-tests step. 12:26:29 INFO - Running pre-action listener: _resource_record_pre_action 12:26:29 INFO - Running main action method: run_tests 12:26:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:26:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:26:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:26:29 INFO - 2017-04-15 12:26:29.031 screenresolution[1629:8165] starting screenresolution argv=screenresolution get 12:26:29 INFO - 2017-04-15 12:26:29.034 screenresolution[1629:8165] Display 0: 1600x1200x32@60 12:26:29 INFO - 2017-04-15 12:26:29.040 screenresolution[1630:8168] starting screenresolution argv=screenresolution list 12:26:29 INFO - Available Modes on Display 0 12:26:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:26:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:26:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:26:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:26:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:26:29 INFO - Intel Iris: 12:26:29 INFO - Chipset Model: Intel Iris 12:26:29 INFO - Type: GPU 12:26:29 INFO - Bus: Built-In 12:26:29 INFO - VRAM (Dynamic, Max): 1536 MB 12:26:29 INFO - Vendor: Intel (0x8086) 12:26:29 INFO - Device ID: 0x0a2e 12:26:29 INFO - Revision ID: 0x0009 12:26:29 INFO - Displays: 12:26:29 INFO - Display: 12:26:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:26:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:26:29 INFO - Display Serial Number: 1600x1200 60 12:26:29 INFO - Main Display: Yes 12:26:29 INFO - Mirror: Off 12:26:29 INFO - Online: Yes 12:26:29 INFO - Rotation: Supported 12:26:29 INFO - Return code: 0 12:26:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:26:29 INFO - Python 2.7.3 12:26:29 INFO - Return code: 0 12:26:29 INFO - grabbing minidump binary from tooltool 12:26: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:26:29 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 0x1084e4d30>, '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 0x10840adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084d9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:26:29 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:26:29 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:26:29 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:26:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:26:29 INFO - Return code: 0 12:26:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:26:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:26:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:26:29 INFO - ENV: RUST_BACKTRACE is now 1 12:26:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:26:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:26:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0243', '--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:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0243 --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:26:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vzSSEiJ2x1/Render', 12:26:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:29 INFO - 'HOME': '/Users/cltbld', 12:26:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:29 INFO - 'LOGNAME': 'cltbld', 12:26:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:26:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:29 INFO - 'MOZ_NO_REMOTE': '1', 12:26:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:26:29 INFO - 'NO_EM_RESTART': '1', 12:26:29 INFO - 'PAGER': '/bin/cat', 12:26:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:29 INFO - 'PWD': '/builds/slave/test', 12:26:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:26:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:29 INFO - 'RUST_BACKTRACE': '1', 12:26:29 INFO - 'SHELL': '/bin/bash', 12:26:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MZUC8bIoSU/Listeners', 12:26:29 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 12:26:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:29 INFO - 'USER': 'cltbld', 12:26:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:29 INFO - 'XPC_FLAGS': '0x0', 12:26:29 INFO - 'XPC_SERVICE_NAME': '0', 12:26:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0243', '--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:26:29 INFO - mozversion application_buildid: 20170415105806 12:26:29 INFO - mozversion application_changeset: ed88aa504601fc1a97ad83f8b4f3c17182a09425 12:26:29 INFO - mozversion application_display_name: Nightly 12:26:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:26:29 INFO - mozversion application_name: Firefox 12:26:29 INFO - mozversion application_remotingname: firefox 12:26:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:26:29 INFO - mozversion application_vendor: Mozilla 12:26:29 INFO - mozversion application_version: 55.0a1 12:26:29 INFO - mozversion platform_buildid: 20170415105806 12:26:29 INFO - mozversion platform_changeset: ed88aa504601fc1a97ad83f8b4f3c17182a09425 12:26:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:26:29 INFO - mozversion platform_version: 55.0a1 12:26:29 INFO - using testdate: 1492284389 12:26:29 INFO - actual date: 1492284389 12:26:29 INFO - starting webserver on 'localhost:49252' 12:26:29 INFO - SUITE-START | Running 2 tests 12:26:29 INFO - TEST-START | dromaeo_css 12:26:29 INFO - operating with platform_type : mac_ 12:26:29 INFO - Initialising browser for dromaeo_css test... 12:26:29 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpubiBNF/profile http://localhost:49252/getInfo.html) 12:26:32 INFO - PID 1640 | __metrics Screen width/height:1600/1200 12:26:32 INFO - PID 1640 | colorDepth:24 12:26:32 INFO - PID 1640 | Browser inner width/height: 1024/689 12:26:32 INFO - PID 1640 | __metrics 12:26:32 INFO - PID 1640 | 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:26:32 INFO - PID 1640 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:26:33 INFO - TEST-INFO | 1640: exit 0 12:26:33 INFO - Browser initialized. 12:26:33 INFO - Running cycle 1/1 for dromaeo_css test... 12:26:33 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpubiBNF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:26:46 INFO - PID 1643 | RSS: Main: 243376128 12:26:46 INFO - PID 1643 | 12:29:50 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49252/tests/dromaeo/cssquery-ext.html) 12:29:52 INFO - PID 1643 | RSS: Main: 369225728 12:29:52 INFO - PID 1643 | 12:31:35 INFO - PID 1643 | ************************* 12:31:35 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 12:31:35 INFO - PID 1643 | 12:31:35 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:31:35 INFO - PID 1643 | Full stack: 12:31:35 INFO - PID 1643 | ************************* 12:31:35 INFO - PID 1643 | ************************* 12:31:35 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 12:31:35 INFO - PID 1643 | 12:31:35 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:31:35 INFO - PID 1643 | Full stack: 12:31:35 INFO - PID 1643 | ************************* 12:31:35 INFO - PID 1643 | ************************* 12:31:35 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 12:31:35 INFO - PID 1643 | 12:31:35 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:31:35 INFO - PID 1643 | Full stack: 12:31:35 INFO - PID 1643 | ************************* 12:31:35 INFO - PID 1643 | ************************* 12:31:35 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 12:31:35 INFO - PID 1643 | 12:31:35 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:31:35 INFO - PID 1643 | Full stack: 12:31:35 INFO - PID 1643 | ************************* 12:32:55 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-ext.html (next: http://localhost:49252/tests/dromaeo/cssquery-jquery.html) 12:32:55 INFO - PID 1643 | RSS: Main: 370364416 12:32:55 INFO - PID 1643 | 12:35:58 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49252/tests/dromaeo/cssquery-mootools.html) 12:35:58 INFO - PID 1643 | RSS: Main: 345997312 12:35:58 INFO - PID 1643 | 12:39:01 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49252/tests/dromaeo/cssquery-prototype.html) 12:39:01 INFO - PID 1643 | RSS: Main: 326717440 12:39:01 INFO - PID 1643 | 12:42:05 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49252/tests/dromaeo/cssquery-yui.html) 12:42:06 INFO - PID 1643 | RSS: Main: 327733248 12:42:06 INFO - PID 1643 | 12:45:08 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-yui.html (next: http://localhost:49252/tests/dromaeo/cssquery-dojo.html) 12:45:08 INFO - PID 1643 | RSS: Main: 380305408 12:45:08 INFO - PID 1643 | 12:45:08 INFO - PID 1643 | __start_tp_report 12:45:08 INFO - PID 1643 | _x_x_mozilla_page_load 12:45:08 INFO - PID 1643 | _x_x_mozilla_page_load_details 12:45:08 INFO - PID 1643 | |i|pagename|runs| 12:45:08 INFO - PID 1643 | |0;dojo.html;3450.6721861423166;3461.082813054539;3485.675443331535;3530.329237444886;3553.9289214215714;5627.127795191752;6134.539909506793;6151.477124444422;6163.229596300463;6168.660723660202;6111.1138884861775;6135.447809697126;6166.475849552793;6169.5989760665525;6202.286737025243;5196.454372290912;5368.46315368462;5372.9462705373035;5386.569074474032;5435.619506634537;5439.700816455093;5460.34475862897;5471.781128754845;5480.369757477902;5545.639533430334;5274.156135018417;5324.254604355393;5334.813281535166;5335.759890804923;5439.5376393006645;5366.926614677081;5379.569634429236;5399.379071406799;5428.0500912340185;5468.863278418032;5292.311999440049;5324.787008519655;5331.920021199685;5333.35999680037;5412.729363531807;5994.07091900756;6034;6174.320824709278;6185.536084793658;6189.226346706661;5387.946120538783;6332.905006424908;6333.87332253357;6342.904856427157;6343.936560634427;6431.839204019937;6551.868962620721;6640.136782218281;6644.734210631569;6649.867002659919;6170.074488826712;6184.5052395808225;6216.627002379826;6239;6241.906371404432;6797.2523022467485;6800.625965571941;6807.115075040213;6812.4550035997;6825.556338838059;6255.343188965184;6277.623342599459;6387.840303992437;6406.423421891959;6421.261554921244;5590.580706446952;6558.049082882955;6573;6624.238212605612;6635;6086.965215913306;6498.870022599522;6525.543211975211;6531.412172904366;6532.771353002622;6321.905171422432;6322;6323.114763933053;6482.870342593122;6555.672216389162;4493.303537951622;5274.868128296824;5281.339832520935;5310.7610157543;5318.813841515528;4670.416197975253;4698.882527936829;4701.670883038223;4709.270063140219;4736.834210802605;6088.238970128734;6184.134221209034;6220.906686399708;6244.562880598405;6245.843853903598;6421.133147025092;6456.225252969673;6456.8062958110395;6483.578567393104;6487.61074335532;6181.474574661204;6195.31851496335;6232.034034724625;6242.875142497124;6268.1851359323;5886.646801191942;5891.911621325684;5892.998190307658;5898.203742494708;5924.911126333109;6348.365163483615;6491.7341118481445;6756.223034351113;6758.864822703518;6784.457243420613;6404.1674582304;6425.58233714807;6442.484601231797;6563.3764792344655;6659.267480577229;5657.264555607745;6718.7312507499155;6731.024001519851;6757.459403247827;6768.018637297466;6458.128152699325;6458.483321334188;6469.805905822833;6474.2554606219;6488.2538508072175;6367.3314301997625;6551.639659818756;6568.8357791055605;6582.736690532325;6592.637404942774;6305.716242769178;6361.745530178741;6371.458426033653;6379.947308694013;6391.169148010915;5656.745446455002;6375;6385.425311721781;6386.872262554816;6387.55287129915;6022;6158.291796443466;6231.376862313732;6243.125962365363;6250;6302.3067462578165;6352.078948552342;6397.616143031433;6418.1656384669695;6471.838204044937;6231.688415579112;6237.095621135;6254.24949006104;6256;6262.5929314594405 12:45:08 INFO - PID 1643 | |1;ext.html;801.4309840013591;821.4660470694048;1139.977200455991;1159.5883461371213;1169.6374124021559;36044;36813.263734725355;36898.07754806128;36901.446478302845;36984.630153698454;38051;38437.615623843754;38442.4233636495;38462.03844903879;38503.614963850356;6139.386061393847;8626.439281446686;8740.606672699743;8754;8755.868661970075;6239;6329.082283068952;6334.651594162319;6336.936630633704;8535.871961920577;8789.95605021974;8836.779080523007;8842.027376988526;8847.77880552988;8874.467531948072;8740.082291359411;8794.648214071494;8807.559622018873;8814.471131732116;8815.691450799191;8552.61513231906;8607.526586037766;8613.138686131399;8632.266257368132;8635.050144484101;36960.815195923846;37241.44137837934;37244.627553724386;37260.62739372626;37387.439188412194;3638.781673099596;3677.7609455385314;3678.6505281998166;3682.907927301812;3688;30351.24121896948;30406.54390184149;30417.847910760305;30428.8478557608;30512.84743576268;3188.28263640679;3222.355528894207;3245.5618491503583;3250.6749325067303;3253.8047717137047;268191;273663;273729;273973;274010.629946851;38264.61735382611;38858;48064.27903581449;48087.519124809005;48125.518744812805;40568;40580.79709601433;40632.59367406288;40648;40797.79601101975;13942.790858137136;14058.297085145701;14162.575122746128;14163.937704672191;14182;11511.712207194887;11522.596709115141;11529.769404612029;11530.423478826193;11567.363794991188;12348.567800126952;12352;12377.257364558156;12384.504619815287;12493.063020273516;5478.068728316116;5501.614886957875;5502;5511.118221084607;5529.30883639545;994.2344394816096;1019.1133713669155;1020.5713600287897;1045.7960697664034;1067.5783065689009;18586.814131858508;22373.328800136023;23537.058517659443;23599.646005309933;23818.819993309655;1034.6844212515105;1084.2735367303926;1124.5726623882872;1134.8524691790014;1135.6309199510026;11298.322100673986;11731.35477548743;11982.58060967862;11988.700282493008;12066.69833254158;291449;291888.2706142913;292053;292417;293002;50925.236121458205;50995.490045099075;51029.489705102475;51038.74480627573;51367.97264054698;1488.6278430392401;1508.781226722119;1542.3059623169618;1546.7525195968592;1547.7833103365538;23105.960231789275;23154.536909261384;23178.841057946698;23229.070837166324;23292.883535582212;36835.815820920725;36882.8155859219;36915.63084369122;36945.81527092347;36986.44520332251;270063;270202;270279;270669.6466517655;271169;29056.854715726287;29477.725729769492;29478.315210598674;33896.49155262722;34086.829565852015;41321.380179296735;41795.7910210447;42149.789251053546;42265.366019509114;42387.72836814901;27674.031408901395;28810.135695929155;29196;29274.41451170922;29480.852595737742;28748.856255718587;28855;29283.26791830136;29654;29676;34747.65252347444;34856.47715284222;34875;35005;35249.295014100084;23859.880700596386;24240.909159087532;24708.38229044288;27978.060334081278;28010.01964931299;20717.482062948548;21634.783652163278;22543.210987615355;22974.39179257436;23064.654030189224 12:45:08 INFO - PID 1643 | |2;jquery.html;421.23680069223565;421.70269959678393;432.4745434297328;433.31536172846904;448.38123389722176;19384.515387115312;21185.258515951926;21729.456763580878;21915.890420547894;21987.670184947237;20665.586688266263;22727.54544909101;23271.76728232717;23393.18123865661;23636.88181559094;6007.969960150193;6232.096346029823;6236.594621349621;6248.31268560458;6251.218597675291;5776.191333213354;6016.669083200422;6049.395060493937;6054.455099041085;6070.0591408331775;5931.644101353911;5952.161592820768;6024.638521688713;6025.367336429677;6042.879142417149;5434.565234781247;5910.1430292607765;5952.136940143677;6070.2108725865355;6090.8781824363705;5232.8691782705355;5316.308879845596;5393;5412.566994640459;5426.21319908615;27018.594721079004;27209;27612.723872761417;27866.442671146666;28082;2206.2167930384803;2284.5430913817304;2288.290629904735;2289.301762962296;2289.3589794857467;16899.324027038903;17470.816147981503;17641.735373969273;18090.819091809175;18329.26682932681;2105.9789402105935;2127.4149608857533;2155.9245426410157;2166.534195148035;2167.1223154622403;159830;160678.58982115277;162107;163549;164841.3515864838;10309.94845025785;11998.460069296903;12230.694232644255;12252;12377.690557736129;16281.860269781238;16295.59261018484;16309.673806523802;16309.858309918192;16342.428015019417;8654.567271636393;8845.380823342304;8862.246709029676;8931.553422328858;8971.461712297152;8495.235428811313;8495.74512764618;8503.787405314917;8681.73954781345;8689.304855611535;7441.85116297671;7581.886271705929;7591.620418979029;7607.543547387175;7624.08510978675;1851.5463711390526;2003.7676828750214;2083.9687404688943;2100.2544096845704;2259.175400978631;913.3469569258012;914.9405288656216;930.232558139524;948.0945696859483;971.1647982734843;19690.90154549218;20386.592268154553;20421.285255016002;20466.692999605017;20597.79402205959;979.5200351827696;990.8860481044773;991.4051569058507;995.1539893497602;1005.2510879394897;10156.765511587439;12089.516419343128;12885.742285154245;13001.674958126123;13920;537818;544768;551692;556214;557772;124760;128331.58342082858;131018;133571.66428335593;135150;1192.4753108632174;1232.9383530823422;1235.9876401235872;1255.0775180242515;1263.2168055805275;19613;21001.474963126046;22055.779442205374;22499.43751406228;22604.434889127904;51772.482275176764;52844.73577632087;53364.93270134653;55039.44960550343;55111.72444137753;69812.30187698058;70578.23554411181;71022.28977710157;71222.28777712157;72125.91811122942;12027.819582706441;12572.937135314265;12778.424970876518;12933.482660693468;12973.481060757842;11618.302901825917;12105.818412723993;13566;13581.049326547047;13923.721525569634;11557.711057223636;11713.648590542298;11784.998275146709;11816.40917954116;11900.880991190324;10822.837657434988;11029.669109926715;11239.775204496027;11357.318560886373;11404.600838970597;10115.443650599287;11405.828912566483;11564.248323858923;11876;11898.583549575724;12501.56244531437;12549.247045177319;12717.427715752998;12819.294938778457;12843.871561284268;11421.714457138638;11473.885261147616;11736.178467507192;11778.46996885125;11852.407379630811 12:45:08 INFO - PID 1643 | |3;mootools.html;1197.5030362399605;1405.206058576904;1472.9779053314203;1496.5435542159637;1500.969980600388;9686.176674982626;10136.986301369869;11391.715207119827;11593.884061159386;11749.7650046999;11325.490352934117;11449.484773185206;11456.198066135374;11464.828027579593;11469.254498457594;2483.0440280492007;2531.139412599716;2531.6835395575554;2535.1127105513106;2540.6062060380577;2115.957680846382;2210.0938615167784;2433.3794882304987;2434.379233295516;2544.160427059066;2496.8501889886666;2509.8619575923317;2531.848089114659;2532.8606926619027;2534.0487824375314;2470.962935555959;2493.4265119022543;2502.361897716071;2507.4985002999474;2511.974880251192;2432.7567243275707;2483.155727052793;2491.7757401833924;2510.57320255557;2512.510060538196;11257.324560526395;11495.540178392854;11508.942455287754;11519.193656444053;11544.76910461786;6491.642959637218;6711.127553418024;6716.093327400836;6730.0577919091365;6740.865182696319;3866.5940076292145;4025.134596061861;4179.9968007677935;4234.25900467417;4324.22164010478;1218.494324855184;1266.8964469045827;1278.603632873812;1300.232862611064;1313.9211647301192;16165.110918899456;16189.757153642704;16219.351225950948;16236.269367878356;16247.106409147493;5562.137868630369;5701.515371193495;6006.069059295816;6022.518198544106;6034.125051867454;13437.529686460926;13448.32758362078;13461.798073028913;13471.797923031163;13482.123661961941;6620.8344791380605;6699.330066993359;6701.530892837454;6747.865042699119;6747.932520674829;5904;6142.232220972379;6162.383761623892;6175.44421002112;6177.320494745574;3689.6679298863232;4168.583141685807;4358.629516491071;4382.896209819304;4410.00774825668;1213.7208442058377;1220.4690959432676;1220.9877901220875;1282.2050328796206;1305.6148436211151;777.5023984649829;805.2189376304975;809.9554524501091;810.8459392715365;815.502543448496;5664.838708064837;6614.140161778938;6721.059051732664;6773.830654233683;6890.10428644273;592.1680039544447;604.2145211225389;621.1862460177182;718.7232915327636;925.4909799610188;4308.655307575386;4312.525622181557;4319.43847299849;4447.688661793708;4474.709143905636;14279.85720142806;14624.46849343751;14863.851361486462;14864.70270594582;14865.331060102322;14830.480933167288;15057.17185554805;15061.924690376478;15064.020838645452;15091.47179848722;7358.448116391399;8649.221570058598;8745.518996455128;8755.91244087551;8798;5851.297844258716;6367.52243581724;6541.771038013647;6753.223379311442;6761.357671021246;13158.40787164599;13203.471861125447;13595.592132236048;13646.24945628;13694.657633558842;11253.437328133725;13627.591172264847;13834.031617786659;13913.582592521836;13916.860831391961;8177;8979.685711000084;9342.579583918876;9429.104235097655;9439.292053095907;10468.738281543023;10655.467226638482;10656.25406221557;10671.253012289375;10675.786484270116;8801.867971980297;9061.456312621263;9083.591238394156;9176.08239176077;9194.816103678022;8888.688895888612;8920.955395222982;8977.371583989057;8988;9030.864537031819;7981.441299109239;8177.100518942792;8177.795555110932;8188.50868947865;8218.424710270223;5061.392632884077;5873.765049397976;6007.3992600739575;6022.488088512526;6135.018397056628;5831.4168583141345;5958.6424814511265;6082;6094.146819445193;6144 12:45:08 INFO - PID 1643 | |4;prototype.html;388.718179319993;396.2985515637322;399.6403237086623;403.77993993273645;405.4303703296868;5906.793262235823;5953.345132035478;5978.9402105978925;5980.132880732292;5983.880322393555;4840.830570930018;5314.5748340132795;5590.692511911843;5649.6327738697055;5812.331581868087;4060.7360521566;4266.743995360281;4474.217012022899;4496.370508128848;4507.323901414781;4482.955170448303;4508;4527.954720452803;4528.705634133771;4534.6372290216705;3659.8902032939054;3758.3422900992355;4341.218580655481;4387.319965405367;4487.945332846778;4358.934615980763;4367.279398899178;4370.868873933755;4372.366006928977;4387.29803231483;3762.115902762876;3773.056735816046;3778.338790711642;3780.584135745066;3781.716371272166;5472.753726082336;5756.942430575683;5765.4811067004175;5771.971140144273;5815.244018277639;5204.375474943031;5226.973865130688;5234.8691282717855;5247.842564723064;5251.107311756972;5761.711914404263;5857.238558987347;6332;6342.778002769927;6356.904646430307;3856.382978723391;3896.3571010783185;4223.598758117974;4306.8277268909205;4313.935290970638;6011.669358185298;6301.558890877641;6380.649064301461;6579.703913323912;6606.735730570819;3694.833732482045;4271.957280427218;4343.609075183249;4351.890267981645;4375.256206444912;4053.290674132074;4147.212029714345;4437.556244375602;4449.443819522559;4454.371920566881;4371.300591905344;4621;4760.262159365304;4890.902181956341;4899.191633380524;5771.499410153307;6283.7800676976085;6285.528585356116;6339.587926784744;6348.460380867678;1426.8299994004817;1490.3516970118033;1504.4959938420752;1511.199064495819;1517.6054225901125;874.5539774714941;983.9016098390103;1011.4790882695418;1013.6097602423121;1021.5454122915231;5312.309399778004;5553.222548843165;5966.373530779292;6010.634044934763;6016.819495415145;5367.436419176009;6083.8479038023515;6521.663059072878;6557.475401967831;6581.74946760114;5944.613600115978;5950.4776369959145;5950.494207992283;5951.196588460502;5975.492083172892;3259.2992506611195;3399.66003399663;3449.758516903843;3456.6716161964573;3467.8439470223398;6626.668666566652;6643.86712265752;6701.6314102723845;6712.899306510406;6727;6707.423755417473;6732.182310776063;6744.2464959110985;6753.729850806011;6753.831154221184;5426.782928682808;6354.809355719336;6701.855406269947;6709.228438729609;6719.832004199934;5491.615586909038;6454.19322584677;6467.902981455188;6513.1532900722605;6532.869342613216;5979.4618484336615;6172.506199504119;6410.871782564416;6437.645929473737;6552.803415897531;6270.968645156745;6459.547831651739;6678.666066696548;6679.599224046573;6863.931360686329;3887.825047872909;4114.814833332447;4135.1316223593385;4212.831486740496;4285.828566857291;5745.368009519033;6459.741610335534;6532.738690452328;6611.735530578723;6629.077567505562;6105.328413874559;6142.293636231711;6295.559310848196;6381.29805721361;6388.8083357499345;6390.456811170917;6403.847307484698;6408.743650253938;6409.262934762562;6483.481321494175;5060.746962651926;5926.288845338415;6208.4722798562625;6217.409346112112;6223.688815559113;6019.729112189874;6328.398802113792;6330.52521060913;6348.143000694847;6404.647744374104;5888.646681199141;6171.84570385744;6211.689415529296;6260.280067792262;6329.620222786648 12:45:08 INFO - PID 1643 | |5;yui.html;713;870.5560164316199;875.7854325690203;879.4942907828;896.6906417286034;12478.500859965601;17419;17831.108444577752;18069.81930180698;18172.273109075653;17575.03337316447;17675.64648707025;18165.364212252574;18422.263109475603;18457.907710461463;975.2393133355994;1003.9849402258972;1008.9646862359818;1009.1422291052584;1009.3439264478075;666.3569655282652;994.4878387630376;995.2635050062937;995.3530205366534;1011.2516737614186;737.6827963975488;1005.2360206243235;1043.3896170740127;1045.4302405189153;1046.7016900183448;1035.9119474844647;1036.6009086501676;1036.8133735927606;1037.097724979269;1043.5512729526301;768.3968085053207;769.1616138409161;769.6036541181296;772.2509166108865;775.3332134364442;15983.680326393524;16343.26455309514;16527.008379497147;16543.503694889172;16842.494725158263;16593.83406165935;16626.085565293903;16823.158842057972;17043.91478042614;17101.31594736209;13712.588622341345;13911.721765564633;13953.860461395358;14055.226962517057;14145.292735363191;3425.554677891883;3450.8274586270586;3453.067671728644;3455.809930453824;3456.844442000116;113436.4328178362;114796.42601787021;114883.42558287238;114955;115680;12096.516139354504;12208.32854193028;12213;12213.69465763363;12224;17105.486835394957;17812.821871781118;19100.2359905605;24381.756182437948;24382.146624868044;7545.886811697719;7603.163651998276;7679.884801727867;7735.419843511759;7738.032745906762;3948.506436695413;4024.396340548941;4036.6367026967127;4038.7980600970423;4044.3529035354204;4152.91694166115;4194.266003449384;4215.768132752667;4262.083652014831;4266.658667306608;883.4699180491782;900.0909081827401;909.9863502047475;910.6266430763355;911.7857303533664;576.9624974376652;652.4649787174471;656.9408753212234;673.3031312591444;691.350130876974;11096.891590597761;11426.371549564687;11642.6507204784;11809.996150327319;12049.578264760692;588.7233000489763;639.133973465947;653.9771108011197;654.4894981914115;670.199112061092;5022.296878437021;5340.394245290539;5391.245225668409;5593.328800543879;5668.26312579362;95575.52212238894;96798;98824.01175988148;99039.50480247552;100866;78446.21553784389;78746.21253787504;79645.60177199077;87011;89926.55036724775;68465.65767171232;69914.65042674856;70431;70835.93746093813;71346.50861659554;7448.8882666758955;7877.172896845748;9723.36798108149;10001.449920254456;10042.748931276776;35213.119672008404;38143.61856381401;38182.85451436461;38224.80887595656;41033.589664102976;59893.700531498806;62430.687846560475;63169.68415157895;65629.67185164044;66949.33050669431;16369.181540923144;16485.928414653008;16489.175541223132;16590.75113873269;16848;17609.29562817473;17911.10444477797;18261.995590242663;18301.816981830012;18346.422447622586;16241.837581624504;16409.58976025609;16547.255373507982;16576.917115414344;16668.49994500167;13782.93108534451;16065.919670401574;16229;16347.34610615562;16564.17179141014;13585.660358491117;15928.522144335688;16000.439984600484;16022.839771602135;16034.278457469674;11526;11758.82361764557;11861.40692965331;11948.163628545919;11985.400729963641;11379.203455758348;11600;12795.808062878878;12888.871111288767;12946 12:45:08 INFO - PID 1643 | __end_tp_report 12:45:08 INFO - PID 1643 | __start_cc_report 12:45:08 INFO - PID 1643 | _x_x_mozilla_cycle_collect,1795 12:45:08 INFO - PID 1643 | __end_cc_report 12:45:08 INFO - PID 1643 | __startTimestamp1492285508768__endTimestamp 12:45:08 INFO - PID 1643 | 12:45:08 INFO - PID 1643 | ------- Summary: start ------- 12:45:08 INFO - PID 1643 | Number of tests: 6 12:45:08 INFO - PID 1643 | 12:45:08 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:6023.20 Median:6243.13 stddev:684.33 (11.0%) stddev-sans-first:656.00 12:45:08 INFO - PID 1643 | Values: 3450.7 3461.1 3485.7 3530.3 3553.9 5627.1 6134.5 6151.5 6163.2 6168.7 6111.1 6135.4 6166.5 6169.6 6202.3 5196.5 5368.5 5372.9 5386.6 5435.6 5439.7 5460.3 5471.8 5480.4 5545.6 5274.2 5324.3 5334.8 5335.8 5439.5 5366.9 5379.6 5399.4 5428.1 5468.9 5292.3 5324.8 5331.9 5333.4 5412.7 5994.1 6034.0 6174.3 6185.5 6189.2 5387.9 6332.9 6333.9 6342.9 6343.9 6431.8 6551.9 6640.1 6644.7 6649.9 6170.1 6184.5 6216.6 6239.0 6241.9 6797.3 6800.6 6807.1 6812.5 6825.6 6255.3 6277.6 6387.8 6406.4 6421.3 5590.6 6558.0 6573.0 6624.2 6635.0 6087.0 6498.9 6525.5 6531.4 6532.8 6321.9 6322.0 6323.1 6482.9 6555.7 4493.3 5274.9 5281.3 5310.8 5318.8 4670.4 4698.9 4701.7 4709.3 4736.8 6088.2 6184.1 6220.9 6244.6 6245.8 6421.1 6456.2 6456.8 6483.6 6487.6 6181.5 6195.3 6232.0 6242.9 6268.2 5886.6 5891.9 5893.0 5898.2 5924.9 6348.4 6491.7 6756.2 6758.9 6784.5 6404.2 6425.6 6442.5 6563.4 6659.3 5657.3 6718.7 6731.0 6757.5 6768.0 6458.1 6458.5 6469.8 6474.3 6488.3 6367.3 6551.6 6568.8 6582.7 6592.6 6305.7 6361.7 6371.5 6379.9 6391.2 5656.7 6375.0 6385.4 6386.9 6387.6 6022.0 6158.3 6231.4 6243.1 6250.0 6302.3 6352.1 6397.6 6418.2 6471.8 6231.7 6237.1 6254.2 6256.0 6262.6 12:45:08 INFO - PID 1643 | 12:45:08 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:42192.21 Median:3205.32 stddev:72933.57 (2275.4%) stddev-sans-first:73071.95 12:45:08 INFO - PID 1643 | Values: 801.4 821.5 1140.0 1159.6 1169.6 36044.0 36813.3 36898.1 36901.4 36984.6 38051.0 38437.6 38442.4 38462.0 38503.6 6139.4 8626.4 8740.6 8754.0 8755.9 6239.0 6329.1 6334.7 6336.9 8535.9 8790.0 8836.8 8842.0 8847.8 8874.5 8740.1 8794.6 8807.6 8814.5 8815.7 8552.6 8607.5 8613.1 8632.3 8635.1 36960.8 37241.4 37244.6 37260.6 37387.4 3638.8 3677.8 3678.7 3682.9 3688.0 30351.2 30406.5 30417.8 30428.8 30512.8 3188.3 3222.4 3245.6 3250.7 3253.8 268191.0 273663.0 273729.0 273973.0 274010.6 38264.6 38858.0 48064.3 48087.5 48125.5 40568.0 40580.8 40632.6 40648.0 40797.8 13942.8 14058.3 14162.6 14163.9 14182.0 11511.7 11522.6 11529.8 11530.4 11567.4 12348.6 12352.0 12377.3 12384.5 12493.1 5478.1 5501.6 5502.0 5511.1 5529.3 994.2 1019.1 1020.6 1045.8 1067.6 18586.8 22373.3 23537.1 23599.6 23818.8 1034.7 1084.3 1124.6 1134.9 1135.6 11298.3 11731.4 11982.6 11988.7 12066.7 291449.0 291888.3 292053.0 292417.0 293002.0 50925.2 50995.5 51029.5 51038.7 51368.0 1488.6 1508.8 1542.3 1546.8 1547.8 23106.0 23154.5 23178.8 23229.1 23292.9 36835.8 36882.8 36915.6 36945.8 36986.4 270063.0 270202.0 270279.0 270669.6 271169.0 29056.9 29477.7 29478.3 33896.5 34086.8 41321.4 41795.8 42149.8 42265.4 42387.7 27674.0 28810.1 29196.0 29274.4 29480.9 28748.9 28855.0 29283.3 29654.0 29676.0 34747.7 34856.5 34875.0 35005.0 35249.3 23859.9 24240.9 24708.4 27978.1 28010.0 20717.5 21634.8 22543.2 22974.4 23064.7 12:45:08 INFO - PID 1643 | 12:45:08 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:35760.94 Median:21822.67 stddev:93403.12 (428.0%) stddev-sans-first:93627.45 12:45:08 INFO - PID 1643 | Values: 421.2 421.7 432.5 433.3 448.4 19384.5 21185.3 21729.5 21915.9 21987.7 20665.6 22727.5 23271.8 23393.2 23636.9 6008.0 6232.1 6236.6 6248.3 6251.2 5776.2 6016.7 6049.4 6054.5 6070.1 5931.6 5952.2 6024.6 6025.4 6042.9 5434.6 5910.1 5952.1 6070.2 6090.9 5232.9 5316.3 5393.0 5412.6 5426.2 27018.6 27209.0 27612.7 27866.4 28082.0 2206.2 2284.5 2288.3 2289.3 2289.4 16899.3 17470.8 17641.7 18090.8 18329.3 2106.0 2127.4 2155.9 2166.5 2167.1 159830.0 160678.6 162107.0 163549.0 164841.4 10309.9 11998.5 12230.7 12252.0 12377.7 16281.9 16295.6 16309.7 16309.9 16342.4 8654.6 8845.4 8862.2 8931.6 8971.5 8495.2 8495.7 8503.8 8681.7 8689.3 7441.9 7581.9 7591.6 7607.5 7624.1 1851.5 2003.8 2084.0 2100.3 2259.2 913.3 914.9 930.2 948.1 971.2 19690.9 20386.6 20421.3 20466.7 20597.8 979.5 990.9 991.4 995.2 1005.3 10156.8 12089.5 12885.7 13001.7 13920.0 537818.0 544768.0 551692.0 556214.0 557772.0 124760.0 128331.6 131018.0 133571.7 135150.0 1192.5 1232.9 1236.0 1255.1 1263.2 19613.0 21001.5 22055.8 22499.4 22604.4 51772.5 52844.7 53364.9 55039.4 55111.7 69812.3 70578.2 71022.3 71222.3 72125.9 12027.8 12572.9 12778.4 12933.5 12973.5 11618.3 12105.8 13566.0 13581.0 13923.7 11557.7 11713.6 11785.0 11816.4 11900.9 10822.8 11029.7 11239.8 11357.3 11404.6 10115.4 11405.8 11564.2 11876.0 11898.6 12501.6 12549.2 12717.4 12819.3 12843.9 11421.7 11473.9 11736.2 11778.5 11852.4 12:45:08 INFO - PID 1643 | 12:45:08 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:7083.50 Median:3945.86 stddev:4497.92 (114.0%) stddev-sans-first:4488.79 12:45:08 INFO - PID 1643 | Values: 1197.5 1405.2 1473.0 1496.5 1501.0 9686.2 10137.0 11391.7 11593.9 11749.8 11325.5 11449.5 11456.2 11464.8 11469.3 2483.0 2531.1 2531.7 2535.1 2540.6 2116.0 2210.1 2433.4 2434.4 2544.2 2496.9 2509.9 2531.8 2532.9 2534.0 2471.0 2493.4 2502.4 2507.5 2512.0 2432.8 2483.2 2491.8 2510.6 2512.5 11257.3 11495.5 11508.9 11519.2 11544.8 6491.6 6711.1 6716.1 6730.1 6740.9 3866.6 4025.1 4180.0 4234.3 4324.2 1218.5 1266.9 1278.6 1300.2 1313.9 16165.1 16189.8 16219.4 16236.3 16247.1 5562.1 5701.5 6006.1 6022.5 6034.1 13437.5 13448.3 13461.8 13471.8 13482.1 6620.8 6699.3 6701.5 6747.9 6747.9 5904.0 6142.2 6162.4 6175.4 6177.3 3689.7 4168.6 4358.6 4382.9 4410.0 1213.7 1220.5 1221.0 1282.2 1305.6 777.5 805.2 810.0 810.8 815.5 5664.8 6614.1 6721.1 6773.8 6890.1 592.2 604.2 621.2 718.7 925.5 4308.7 4312.5 4319.4 4447.7 4474.7 14279.9 14624.5 14863.9 14864.7 14865.3 14830.5 15057.2 15061.9 15064.0 15091.5 7358.4 8649.2 8745.5 8755.9 8798.0 5851.3 6367.5 6541.8 6753.2 6761.4 13158.4 13203.5 13595.6 13646.2 13694.7 11253.4 13627.6 13834.0 13913.6 13916.9 8177.0 8979.7 9342.6 9429.1 9439.3 10468.7 10655.5 10656.3 10671.3 10675.8 8801.9 9061.5 9083.6 9176.1 9194.8 8888.7 8921.0 8977.4 8988.0 9030.9 7981.4 8177.1 8177.8 8188.5 8218.4 5061.4 5873.8 6007.4 6022.5 6135.0 5831.4 5958.6 6082.0 6094.1 6144.0 12:45:08 INFO - PID 1643 | 12:45:08 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:5121.42 Median:5813.79 stddev:1602.43 (27.6%) stddev-sans-first:1567.06 12:45:08 INFO - PID 1643 | Values: 388.7 396.3 399.6 403.8 405.4 5906.8 5953.3 5978.9 5980.1 5983.9 4840.8 5314.6 5590.7 5649.6 5812.3 4060.7 4266.7 4474.2 4496.4 4507.3 4483.0 4508.0 4528.0 4528.7 4534.6 3659.9 3758.3 4341.2 4387.3 4487.9 4358.9 4367.3 4370.9 4372.4 4387.3 3762.1 3773.1 3778.3 3780.6 3781.7 5472.8 5756.9 5765.5 5772.0 5815.2 5204.4 5227.0 5234.9 5247.8 5251.1 5761.7 5857.2 6332.0 6342.8 6356.9 3856.4 3896.4 4223.6 4306.8 4313.9 6011.7 6301.6 6380.6 6579.7 6606.7 3694.8 4272.0 4343.6 4351.9 4375.3 4053.3 4147.2 4437.6 4449.4 4454.4 4371.3 4621.0 4760.3 4890.9 4899.2 5771.5 6283.8 6285.5 6339.6 6348.5 1426.8 1490.4 1504.5 1511.2 1517.6 874.6 983.9 1011.5 1013.6 1021.5 5312.3 5553.2 5966.4 6010.6 6016.8 5367.4 6083.8 6521.7 6557.5 6581.7 5944.6 5950.5 5950.5 5951.2 5975.5 3259.3 3399.7 3449.8 3456.7 3467.8 6626.7 6643.9 6701.6 6712.9 6727.0 6707.4 6732.2 6744.2 6753.7 6753.8 5426.8 6354.8 6701.9 6709.2 6719.8 5491.6 6454.2 6467.9 6513.2 6532.9 5979.5 6172.5 6410.9 6437.6 6552.8 6271.0 6459.5 6678.7 6679.6 6863.9 3887.8 4114.8 4135.1 4212.8 4285.8 5745.4 6459.7 6532.7 6611.7 6629.1 6105.3 6142.3 6295.6 6381.3 6388.8 6390.5 6403.8 6408.7 6409.3 6483.5 5060.7 5926.3 6208.5 6217.4 6223.7 6019.7 6328.4 6330.5 6348.1 6404.6 5888.6 6171.8 6211.7 6260.3 6329.6 12:45:08 INFO - PID 1643 | 12:45:08 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:20618.22 Median:18324.12 stddev:28356.36 (154.7%) stddev-sans-first:28396.52 12:45:08 INFO - PID 1643 | Values: 713.0 870.6 875.8 879.5 896.7 12478.5 17419.0 17831.1 18069.8 18172.3 17575.0 17675.6 18165.4 18422.3 18457.9 975.2 1004.0 1009.0 1009.1 1009.3 666.4 994.5 995.3 995.4 1011.3 737.7 1005.2 1043.4 1045.4 1046.7 1035.9 1036.6 1036.8 1037.1 1043.6 768.4 769.2 769.6 772.3 775.3 15983.7 16343.3 16527.0 16543.5 16842.5 16593.8 16626.1 16823.2 17043.9 17101.3 13712.6 13911.7 13953.9 14055.2 14145.3 3425.6 3450.8 3453.1 3455.8 3456.8 113436.4 114796.4 114883.4 114955.0 115680.0 12096.5 12208.3 12213.0 12213.7 12224.0 17105.5 17812.8 19100.2 24381.8 24382.1 7545.9 7603.2 7679.9 7735.4 7738.0 3948.5 4024.4 4036.6 4038.8 4044.4 4152.9 4194.3 4215.8 4262.1 4266.7 883.5 900.1 910.0 910.6 911.8 577.0 652.5 656.9 673.3 691.4 11096.9 11426.4 11642.7 11810.0 12049.6 588.7 639.1 654.0 654.5 670.2 5022.3 5340.4 5391.2 5593.3 5668.3 95575.5 96798.0 98824.0 99039.5 100866.0 78446.2 78746.2 79645.6 87011.0 89926.6 68465.7 69914.7 70431.0 70835.9 71346.5 7448.9 7877.2 9723.4 10001.4 10042.7 35213.1 38143.6 38182.9 38224.8 41033.6 59893.7 62430.7 63169.7 65629.7 66949.3 16369.2 16485.9 16489.2 16590.8 16848.0 17609.3 17911.1 18262.0 18301.8 18346.4 16241.8 16409.6 16547.3 16576.9 16668.5 13782.9 16065.9 16229.0 16347.3 16564.2 13585.7 15928.5 16000.4 16022.8 16034.3 11526.0 11758.8 11861.4 11948.2 11985.4 11379.2 11600.0 12795.8 12888.9 12946.0 12:45:08 INFO - PID 1643 | -------- Summary: end -------- 12:45:08 INFO - PID 1643 | 12:45:09 INFO - TEST-INFO | 1643: exit 0 12:45:09 INFO - TEST-OK | dromaeo_css | took 1119913ms 12:45:09 INFO - TEST-START | kraken 12:45:09 INFO - operating with platform_type : mac_ 12:45:09 INFO - Initialising browser for kraken test... 12:45:09 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmp5_XwX4/profile http://localhost:49252/getInfo.html) 12:45:12 INFO - PID 1651 | __metrics Screen width/height:1600/1200 12:45:12 INFO - PID 1651 | colorDepth:24 12:45:12 INFO - PID 1651 | Browser inner width/height: 1024/689 12:45:12 INFO - PID 1651 | __metrics 12:45:12 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:45:12 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:45:13 INFO - TEST-INFO | 1651: exit 0 12:45:13 INFO - Browser initialized. 12:45:13 INFO - Running cycle 1/1 for kraken test... 12:45:13 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmp5_XwX4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:45:25 INFO - PID 1652 | RSS: Main: 244404224 12:45:25 INFO - PID 1652 | 12:45:28 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection) 12:45:29 INFO - PID 1652 | RSS: Main: 313057280 12:45:29 INFO - PID 1652 | 12:45:31 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-dft) 12:45:32 INFO - PID 1652 | RSS: Main: 293670912 12:45:32 INFO - PID 1652 | 12:45:35 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-fft) 12:45:36 INFO - PID 1652 | RSS: Main: 386793472 12:45:36 INFO - PID 1652 | 12:45:38 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator) 12:45:39 INFO - PID 1652 | RSS: Main: 289542144 12:45:39 INFO - PID 1652 | 12:45:41 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:45:41 INFO - PID 1652 | RSS: Main: 291889152 12:45:41 INFO - PID 1652 | 12:45:44 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom) 12:45:45 INFO - PID 1652 | RSS: Main: 355147776 12:45:45 INFO - PID 1652 | 12:45:47 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate) 12:45:48 INFO - PID 1652 | RSS: Main: 370692096 12:45:48 INFO - PID 1652 | 12:45:51 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial) 12:45:52 INFO - PID 1652 | RSS: Main: 379912192 12:45:52 INFO - PID 1652 | 12:45:53 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:45:54 INFO - PID 1652 | RSS: Main: 334770176 12:45:54 INFO - PID 1652 | 12:45:55 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:45:56 INFO - PID 1652 | RSS: Main: 333975552 12:45:56 INFO - PID 1652 | 12:45:58 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:45:59 INFO - PID 1652 | RSS: Main: 335847424 12:45:59 INFO - PID 1652 | 12:46:02 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:46:02 INFO - PID 1652 | RSS: Main: 354160640 12:46:02 INFO - PID 1652 | 12:46:06 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:46:06 INFO - PID 1652 | RSS: Main: 346279936 12:46:06 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49252/tests/kraken/driver.html?testName=ai-astar) 12:46:08 INFO - PID 1652 | RSS: Main: 388743168 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | __start_tp_report 12:46:08 INFO - PID 1652 | _x_x_mozilla_page_load 12:46:08 INFO - PID 1652 | _x_x_mozilla_page_load_details 12:46:08 INFO - PID 1652 | |i|pagename|runs| 12:46:08 INFO - PID 1652 | |0;ai-astar;110;110;110;111;110;110;110;111;110;110 12:46:08 INFO - PID 1652 | |1;audio-beat-detection;145;109;109;149;109;107;108;106;138;118 12:46:08 INFO - PID 1652 | |2;audio-dft;189;182;183;188;184;184;185;181;186;208 12:46:08 INFO - PID 1652 | |3;audio-fft;76;61;63;115;84;60;60;61;86;57 12:46:08 INFO - PID 1652 | |4;audio-oscillator;92;70;85;71;69;69;90;68;69;90 12:46:08 INFO - PID 1652 | |5;imaging-gaussian-blur;89;89;88;88;88;87;88;87;88;89 12:46:08 INFO - PID 1652 | |6;imaging-darkroom;96;96;96;96;95;96;96;95;95;95 12:46:08 INFO - PID 1652 | |7;imaging-desaturate;84;84;83;86;84;83;85;88;84;84 12:46:08 INFO - PID 1652 | |8;json-parse-financial;49;49;50;49;50;51;48;51;49;49 12:46:08 INFO - PID 1652 | |9;json-stringify-tinderbox;55;61;57;65;66;59;55;58;57;57 12:46:08 INFO - PID 1652 | |10;stanford-crypto-aes;83;82;86;83;81;82;83;82;82;82 12:46:08 INFO - PID 1652 | |11;stanford-crypto-ccm;137;143;132;137;139;135;141;126;170;148 12:46:08 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;182;187;186;208;188;187;181;219;221;181 12:46:08 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;67;69;67;66;65;68;66;84;91;90 12:46:08 INFO - PID 1652 | __end_tp_report 12:46:08 INFO - PID 1652 | __start_cc_report 12:46:08 INFO - PID 1652 | _x_x_mozilla_cycle_collect,2302 12:46:08 INFO - PID 1652 | __end_cc_report 12:46:08 INFO - PID 1652 | __startTimestamp1492285568916__endTimestamp 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | ------- Summary: start ------- 12:46:08 INFO - PID 1652 | Number of tests: 14 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:46:08 INFO - PID 1652 | Values: 110.0 110.0 110.0 111.0 110.0 110.0 110.0 111.0 110.0 110.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:113.50 stddev:17.21 (15.2%) stddev-sans-first:15.65 12:46:08 INFO - PID 1652 | Values: 145.0 109.0 109.0 149.0 109.0 107.0 108.0 106.0 138.0 118.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:187.00 Median:185.50 stddev:7.79 (4.2%) stddev-sans-first:8.23 12:46:08 INFO - PID 1652 | Values: 189.0 182.0 183.0 188.0 184.0 184.0 185.0 181.0 186.0 208.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:72.30 Median:62.00 stddev:18.38 (29.6%) stddev-sans-first:19.45 12:46:08 INFO - PID 1652 | Values: 76.0 61.0 63.0 115.0 84.0 60.0 60.0 61.0 86.0 57.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.00 stddev:10.46 (13.4%) stddev-sans-first:9.64 12:46:08 INFO - PID 1652 | Values: 92.0 70.0 85.0 71.0 69.0 69.0 90.0 68.0 69.0 90.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:88.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 12:46:08 INFO - PID 1652 | Values: 89.0 89.0 88.0 88.0 88.0 87.0 88.0 87.0 88.0 89.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:46:08 INFO - PID 1652 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.00 stddev:1.51 (1.8%) stddev-sans-first:1.59 12:46:08 INFO - PID 1652 | Values: 84.0 84.0 83.0 86.0 84.0 83.0 85.0 88.0 84.0 84.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:49.50 stddev:0.97 (2.0%) stddev-sans-first:1.01 12:46:08 INFO - PID 1652 | Values: 49.0 49.0 50.0 49.0 50.0 51.0 48.0 51.0 49.0 49.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:58.50 stddev:3.86 (6.6%) stddev-sans-first:3.81 12:46:08 INFO - PID 1652 | Values: 55.0 61.0 57.0 65.0 66.0 59.0 55.0 58.0 57.0 57.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:1.35 (1.6%) stddev-sans-first:1.42 12:46:08 INFO - PID 1652 | Values: 83.0 82.0 86.0 83.0 81.0 82.0 83.0 82.0 82.0 82.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:140.00 stddev:11.89 (8.5%) stddev-sans-first:12.53 12:46:08 INFO - PID 1652 | Values: 137.0 143.0 132.0 137.0 139.0 135.0 141.0 126.0 170.0 148.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.00 Median:187.50 stddev:15.74 (8.4%) stddev-sans-first:16.09 12:46:08 INFO - PID 1652 | Values: 182.0 187.0 186.0 208.0 188.0 187.0 181.0 219.0 221.0 181.0 12:46:08 INFO - PID 1652 | 12:46:08 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:68.50 stddev:10.58 (15.5%) stddev-sans-first:10.98 12:46:08 INFO - PID 1652 | Values: 67.0 69.0 67.0 66.0 65.0 68.0 66.0 84.0 91.0 90.0 12:46:08 INFO - PID 1652 | -------- Summary: end -------- 12:46:08 INFO - PID 1652 | 12:46:10 INFO - TEST-INFO | 1652: exit 0 12:46:10 INFO - TEST-OK | kraken | took 60565ms 12:46:10 INFO - SUITE-END | took 1180s 12:46:10 INFO - Completed test suite (00:19:40) 12:46:10 INFO - javascript benchmark 12:46:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7723.853364584256, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3450.6721861423166, 3461.082813054539, 3485.675443331535, 3530.329237444886, 3553.9289214215714, 5627.127795191752, 6134.539909506793, 6151.477124444422, 6163.229596300463, 6168.660723660202, 6111.1138884861775, 6135.447809697126, 6166.475849552793, 6169.5989760665525, 6202.286737025243, 5196.454372290912, 5368.46315368462, 5372.9462705373035, 5386.569074474032, 5435.619506634537, 5439.700816455093, 5460.34475862897, 5471.781128754845, 5480.369757477902, 5545.639533430334, 5274.156135018417, 5324.254604355393, 5334.813281535166, 5335.759890804923, 5439.5376393006645, 5366.926614677081, 5379.569634429236, 5399.379071406799, 5428.0500912340185, 5468.863278418032, 5292.311999440049, 5324.787008519655, 5331.920021199685, 5333.35999680037, 5412.729363531807, 5994.07091900756, 6034.0, 6174.320824709278, 6185.536084793658, 6189.226346706661, 5387.946120538783, 6332.905006424908, 6333.87332253357, 6342.904856427157, 6343.936560634427, 6431.839204019937, 6551.868962620721, 6640.136782218281, 6644.734210631569, 6649.867002659919, 6170.074488826712, 6184.5052395808225, 6216.627002379826, 6239.0, 6241.906371404432, 6797.2523022467485, 6800.625965571941, 6807.115075040213, 6812.4550035997, 6825.556338838059, 6255.343188965184, 6277.623342599459, 6387.840303992437, 6406.423421891959, 6421.261554921244, 5590.580706446952, 6558.049082882955, 6573.0, 6624.238212605612, 6635.0, 6086.965215913306, 6498.870022599522, 6525.543211975211, 6531.412172904366, 6532.771353002622, 6321.905171422432, 6322.0, 6323.114763933053, 6482.870342593122, 6555.672216389162, 4493.303537951622, 5274.868128296824, 5281.339832520935, 5310.7610157543, 5318.813841515528, 4670.416197975253, 4698.882527936829, 4701.670883038223, 4709.270063140219, 4736.834210802605, 6088.238970128734, 6184.134221209034, 6220.906686399708, 6244.562880598405, 6245.843853903598, 6421.133147025092, 6456.225252969673, 6456.8062958110395, 6483.578567393104, 6487.61074335532, 6181.474574661204, 6195.31851496335, 6232.034034724625, 6242.875142497124, 6268.1851359323, 5886.646801191942, 5891.911621325684, 5892.998190307658, 5898.203742494708, 5924.911126333109, 6348.365163483615, 6491.7341118481445, 6756.223034351113, 6758.864822703518, 6784.457243420613, 6404.1674582304, 6425.58233714807, 6442.484601231797, 6563.3764792344655, 6659.267480577229, 5657.264555607745, 6718.7312507499155, 6731.024001519851, 6757.459403247827, 6768.018637297466, 6458.128152699325, 6458.483321334188, 6469.805905822833, 6474.2554606219, 6488.2538508072175, 6367.3314301997625, 6551.639659818756, 6568.8357791055605, 6582.736690532325, 6592.637404942774, 6305.716242769178, 6361.745530178741, 6371.458426033653, 6379.947308694013, 6391.169148010915, 5656.745446455002, 6375.0, 6385.425311721781, 6386.872262554816, 6387.55287129915, 6022.0, 6158.291796443466, 6231.376862313732, 6243.125962365363, 6250.0, 6302.3067462578165, 6352.078948552342, 6397.616143031433, 6418.1656384669695, 6471.838204044937, 6231.688415579112, 6237.095621135, 6254.24949006104, 6256.0, 6262.5929314594405], "value": 5979.3480939099645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.4309840013591, 821.4660470694048, 1139.977200455991, 1159.5883461371213, 1169.6374124021559, 36044.0, 36813.263734725355, 36898.07754806128, 36901.446478302845, 36984.630153698454, 38051.0, 38437.615623843754, 38442.4233636495, 38462.03844903879, 38503.614963850356, 6139.386061393847, 8626.439281446686, 8740.606672699743, 8754.0, 8755.868661970075, 6239.0, 6329.082283068952, 6334.651594162319, 6336.936630633704, 8535.871961920577, 8789.95605021974, 8836.779080523007, 8842.027376988526, 8847.77880552988, 8874.467531948072, 8740.082291359411, 8794.648214071494, 8807.559622018873, 8814.471131732116, 8815.691450799191, 8552.61513231906, 8607.526586037766, 8613.138686131399, 8632.266257368132, 8635.050144484101, 36960.815195923846, 37241.44137837934, 37244.627553724386, 37260.62739372626, 37387.439188412194, 3638.781673099596, 3677.7609455385314, 3678.6505281998166, 3682.907927301812, 3688.0, 30351.24121896948, 30406.54390184149, 30417.847910760305, 30428.8478557608, 30512.84743576268, 3188.28263640679, 3222.355528894207, 3245.5618491503583, 3250.6749325067303, 3253.8047717137047, 268191.0, 273663.0, 273729.0, 273973.0, 274010.629946851, 38264.61735382611, 38858.0, 48064.27903581449, 48087.519124809005, 48125.518744812805, 40568.0, 40580.79709601433, 40632.59367406288, 40648.0, 40797.79601101975, 13942.790858137136, 14058.297085145701, 14162.575122746128, 14163.937704672191, 14182.0, 11511.712207194887, 11522.596709115141, 11529.769404612029, 11530.423478826193, 11567.363794991188, 12348.567800126952, 12352.0, 12377.257364558156, 12384.504619815287, 12493.063020273516, 5478.068728316116, 5501.614886957875, 5502.0, 5511.118221084607, 5529.30883639545, 994.2344394816096, 1019.1133713669155, 1020.5713600287897, 1045.7960697664034, 1067.5783065689009, 18586.814131858508, 22373.328800136023, 23537.058517659443, 23599.646005309933, 23818.819993309655, 1034.6844212515105, 1084.2735367303926, 1124.5726623882872, 1134.8524691790014, 1135.6309199510026, 11298.322100673986, 11731.35477548743, 11982.58060967862, 11988.700282493008, 12066.69833254158, 291449.0, 291888.2706142913, 292053.0, 292417.0, 293002.0, 50925.236121458205, 50995.490045099075, 51029.489705102475, 51038.74480627573, 51367.97264054698, 1488.6278430392401, 1508.781226722119, 1542.3059623169618, 1546.7525195968592, 1547.7833103365538, 23105.960231789275, 23154.536909261384, 23178.841057946698, 23229.070837166324, 23292.883535582212, 36835.815820920725, 36882.8155859219, 36915.63084369122, 36945.81527092347, 36986.44520332251, 270063.0, 270202.0, 270279.0, 270669.6466517655, 271169.0, 29056.854715726287, 29477.725729769492, 29478.315210598674, 33896.49155262722, 34086.829565852015, 41321.380179296735, 41795.7910210447, 42149.789251053546, 42265.366019509114, 42387.72836814901, 27674.031408901395, 28810.135695929155, 29196.0, 29274.41451170922, 29480.852595737742, 28748.856255718587, 28855.0, 29283.26791830136, 29654.0, 29676.0, 34747.65252347444, 34856.47715284222, 34875.0, 35005.0, 35249.295014100084, 23859.880700596386, 24240.909159087532, 24708.38229044288, 27978.060334081278, 28010.01964931299, 20717.482062948548, 21634.783652163278, 22543.210987615355, 22974.39179257436, 23064.654030189224], "value": 16826.96678067433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.23680069223565, 421.70269959678393, 432.4745434297328, 433.31536172846904, 448.38123389722176, 19384.515387115312, 21185.258515951926, 21729.456763580878, 21915.890420547894, 21987.670184947237, 20665.586688266263, 22727.54544909101, 23271.76728232717, 23393.18123865661, 23636.88181559094, 6007.969960150193, 6232.096346029823, 6236.594621349621, 6248.31268560458, 6251.218597675291, 5776.191333213354, 6016.669083200422, 6049.395060493937, 6054.455099041085, 6070.0591408331775, 5931.644101353911, 5952.161592820768, 6024.638521688713, 6025.367336429677, 6042.879142417149, 5434.565234781247, 5910.1430292607765, 5952.136940143677, 6070.2108725865355, 6090.8781824363705, 5232.8691782705355, 5316.308879845596, 5393.0, 5412.566994640459, 5426.21319908615, 27018.594721079004, 27209.0, 27612.723872761417, 27866.442671146666, 28082.0, 2206.2167930384803, 2284.5430913817304, 2288.290629904735, 2289.301762962296, 2289.3589794857467, 16899.324027038903, 17470.816147981503, 17641.735373969273, 18090.819091809175, 18329.26682932681, 2105.9789402105935, 2127.4149608857533, 2155.9245426410157, 2166.534195148035, 2167.1223154622403, 159830.0, 160678.58982115277, 162107.0, 163549.0, 164841.3515864838, 10309.94845025785, 11998.460069296903, 12230.694232644255, 12252.0, 12377.690557736129, 16281.860269781238, 16295.59261018484, 16309.673806523802, 16309.858309918192, 16342.428015019417, 8654.567271636393, 8845.380823342304, 8862.246709029676, 8931.553422328858, 8971.461712297152, 8495.235428811313, 8495.74512764618, 8503.787405314917, 8681.73954781345, 8689.304855611535, 7441.85116297671, 7581.886271705929, 7591.620418979029, 7607.543547387175, 7624.08510978675, 1851.5463711390526, 2003.7676828750214, 2083.9687404688943, 2100.2544096845704, 2259.175400978631, 913.3469569258012, 914.9405288656216, 930.232558139524, 948.0945696859483, 971.1647982734843, 19690.90154549218, 20386.592268154553, 20421.285255016002, 20466.692999605017, 20597.79402205959, 979.5200351827696, 990.8860481044773, 991.4051569058507, 995.1539893497602, 1005.2510879394897, 10156.765511587439, 12089.516419343128, 12885.742285154245, 13001.674958126123, 13920.0, 537818.0, 544768.0, 551692.0, 556214.0, 557772.0, 124760.0, 128331.58342082858, 131018.0, 133571.66428335593, 135150.0, 1192.4753108632174, 1232.9383530823422, 1235.9876401235872, 1255.0775180242515, 1263.2168055805275, 19613.0, 21001.474963126046, 22055.779442205374, 22499.43751406228, 22604.434889127904, 51772.482275176764, 52844.73577632087, 53364.93270134653, 55039.44960550343, 55111.72444137753, 69812.30187698058, 70578.23554411181, 71022.28977710157, 71222.28777712157, 72125.91811122942, 12027.819582706441, 12572.937135314265, 12778.424970876518, 12933.482660693468, 12973.481060757842, 11618.302901825917, 12105.818412723993, 13566.0, 13581.049326547047, 13923.721525569634, 11557.711057223636, 11713.648590542298, 11784.998275146709, 11816.40917954116, 11900.880991190324, 10822.837657434988, 11029.669109926715, 11239.775204496027, 11357.318560886373, 11404.600838970597, 10115.443650599287, 11405.828912566483, 11564.248323858923, 11876.0, 11898.583549575724, 12501.56244531437, 12549.247045177319, 12717.427715752998, 12819.294938778457, 12843.871561284268, 11421.714457138638, 11473.885261147616, 11736.178467507192, 11778.46996885125, 11852.407379630811], "value": 10593.930333591217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1197.5030362399605, 1405.206058576904, 1472.9779053314203, 1496.5435542159637, 1500.969980600388, 9686.176674982626, 10136.986301369869, 11391.715207119827, 11593.884061159386, 11749.7650046999, 11325.490352934117, 11449.484773185206, 11456.198066135374, 11464.828027579593, 11469.254498457594, 2483.0440280492007, 2531.139412599716, 2531.6835395575554, 2535.1127105513106, 2540.6062060380577, 2115.957680846382, 2210.0938615167784, 2433.3794882304987, 2434.379233295516, 2544.160427059066, 2496.8501889886666, 2509.8619575923317, 2531.848089114659, 2532.8606926619027, 2534.0487824375314, 2470.962935555959, 2493.4265119022543, 2502.361897716071, 2507.4985002999474, 2511.974880251192, 2432.7567243275707, 2483.155727052793, 2491.7757401833924, 2510.57320255557, 2512.510060538196, 11257.324560526395, 11495.540178392854, 11508.942455287754, 11519.193656444053, 11544.76910461786, 6491.642959637218, 6711.127553418024, 6716.093327400836, 6730.0577919091365, 6740.865182696319, 3866.5940076292145, 4025.134596061861, 4179.9968007677935, 4234.25900467417, 4324.22164010478, 1218.494324855184, 1266.8964469045827, 1278.603632873812, 1300.232862611064, 1313.9211647301192, 16165.110918899456, 16189.757153642704, 16219.351225950948, 16236.269367878356, 16247.106409147493, 5562.137868630369, 5701.515371193495, 6006.069059295816, 6022.518198544106, 6034.125051867454, 13437.529686460926, 13448.32758362078, 13461.798073028913, 13471.797923031163, 13482.123661961941, 6620.8344791380605, 6699.330066993359, 6701.530892837454, 6747.865042699119, 6747.932520674829, 5904.0, 6142.232220972379, 6162.383761623892, 6175.44421002112, 6177.320494745574, 3689.6679298863232, 4168.583141685807, 4358.629516491071, 4382.896209819304, 4410.00774825668, 1213.7208442058377, 1220.4690959432676, 1220.9877901220875, 1282.2050328796206, 1305.6148436211151, 777.5023984649829, 805.2189376304975, 809.9554524501091, 810.8459392715365, 815.502543448496, 5664.838708064837, 6614.140161778938, 6721.059051732664, 6773.830654233683, 6890.10428644273, 592.1680039544447, 604.2145211225389, 621.1862460177182, 718.7232915327636, 925.4909799610188, 4308.655307575386, 4312.525622181557, 4319.43847299849, 4447.688661793708, 4474.709143905636, 14279.85720142806, 14624.46849343751, 14863.851361486462, 14864.70270594582, 14865.331060102322, 14830.480933167288, 15057.17185554805, 15061.924690376478, 15064.020838645452, 15091.47179848722, 7358.448116391399, 8649.221570058598, 8745.518996455128, 8755.91244087551, 8798.0, 5851.297844258716, 6367.52243581724, 6541.771038013647, 6753.223379311442, 6761.357671021246, 13158.40787164599, 13203.471861125447, 13595.592132236048, 13646.24945628, 13694.657633558842, 11253.437328133725, 13627.591172264847, 13834.031617786659, 13913.582592521836, 13916.860831391961, 8177.0, 8979.685711000084, 9342.579583918876, 9429.104235097655, 9439.292053095907, 10468.738281543023, 10655.467226638482, 10656.25406221557, 10671.253012289375, 10675.786484270116, 8801.867971980297, 9061.456312621263, 9083.591238394156, 9176.08239176077, 9194.816103678022, 8888.688895888612, 8920.955395222982, 8977.371583989057, 8988.0, 9030.864537031819, 7981.441299109239, 8177.100518942792, 8177.795555110932, 8188.50868947865, 8218.424710270223, 5061.392632884077, 5873.765049397976, 6007.3992600739575, 6022.488088512526, 6135.018397056628, 5831.4168583141345, 5958.6424814511265, 6082.0, 6094.146819445193, 6144.0], "value": 5324.426636005387, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.718179319993, 396.2985515637322, 399.6403237086623, 403.77993993273645, 405.4303703296868, 5906.793262235823, 5953.345132035478, 5978.9402105978925, 5980.132880732292, 5983.880322393555, 4840.830570930018, 5314.5748340132795, 5590.692511911843, 5649.6327738697055, 5812.331581868087, 4060.7360521566, 4266.743995360281, 4474.217012022899, 4496.370508128848, 4507.323901414781, 4482.955170448303, 4508.0, 4527.954720452803, 4528.705634133771, 4534.6372290216705, 3659.8902032939054, 3758.3422900992355, 4341.218580655481, 4387.319965405367, 4487.945332846778, 4358.934615980763, 4367.279398899178, 4370.868873933755, 4372.366006928977, 4387.29803231483, 3762.115902762876, 3773.056735816046, 3778.338790711642, 3780.584135745066, 3781.716371272166, 5472.753726082336, 5756.942430575683, 5765.4811067004175, 5771.971140144273, 5815.244018277639, 5204.375474943031, 5226.973865130688, 5234.8691282717855, 5247.842564723064, 5251.107311756972, 5761.711914404263, 5857.238558987347, 6332.0, 6342.778002769927, 6356.904646430307, 3856.382978723391, 3896.3571010783185, 4223.598758117974, 4306.8277268909205, 4313.935290970638, 6011.669358185298, 6301.558890877641, 6380.649064301461, 6579.703913323912, 6606.735730570819, 3694.833732482045, 4271.957280427218, 4343.609075183249, 4351.890267981645, 4375.256206444912, 4053.290674132074, 4147.212029714345, 4437.556244375602, 4449.443819522559, 4454.371920566881, 4371.300591905344, 4621.0, 4760.262159365304, 4890.902181956341, 4899.191633380524, 5771.499410153307, 6283.7800676976085, 6285.528585356116, 6339.587926784744, 6348.460380867678, 1426.8299994004817, 1490.3516970118033, 1504.4959938420752, 1511.199064495819, 1517.6054225901125, 874.5539774714941, 983.9016098390103, 1011.4790882695418, 1013.6097602423121, 1021.5454122915231, 5312.309399778004, 5553.222548843165, 5966.373530779292, 6010.634044934763, 6016.819495415145, 5367.436419176009, 6083.8479038023515, 6521.663059072878, 6557.475401967831, 6581.74946760114, 5944.613600115978, 5950.4776369959145, 5950.494207992283, 5951.196588460502, 5975.492083172892, 3259.2992506611195, 3399.66003399663, 3449.758516903843, 3456.6716161964573, 3467.8439470223398, 6626.668666566652, 6643.86712265752, 6701.6314102723845, 6712.899306510406, 6727.0, 6707.423755417473, 6732.182310776063, 6744.2464959110985, 6753.729850806011, 6753.831154221184, 5426.782928682808, 6354.809355719336, 6701.855406269947, 6709.228438729609, 6719.832004199934, 5491.615586909038, 6454.19322584677, 6467.902981455188, 6513.1532900722605, 6532.869342613216, 5979.4618484336615, 6172.506199504119, 6410.871782564416, 6437.645929473737, 6552.803415897531, 6270.968645156745, 6459.547831651739, 6678.666066696548, 6679.599224046573, 6863.931360686329, 3887.825047872909, 4114.814833332447, 4135.1316223593385, 4212.831486740496, 4285.828566857291, 5745.368009519033, 6459.741610335534, 6532.738690452328, 6611.735530578723, 6629.077567505562, 6105.328413874559, 6142.293636231711, 6295.559310848196, 6381.29805721361, 6388.8083357499345, 6390.456811170917, 6403.847307484698, 6408.743650253938, 6409.262934762562, 6483.481321494175, 5060.746962651926, 5926.288845338415, 6208.4722798562625, 6217.409346112112, 6223.688815559113, 6019.729112189874, 6328.398802113792, 6330.52521060913, 6348.143000694847, 6404.647744374104, 5888.646681199141, 6171.84570385744, 6211.689415529296, 6260.280067792262, 6329.620222786648], "value": 4623.311802769282, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.0, 870.5560164316199, 875.7854325690203, 879.4942907828, 896.6906417286034, 12478.500859965601, 17419.0, 17831.108444577752, 18069.81930180698, 18172.273109075653, 17575.03337316447, 17675.64648707025, 18165.364212252574, 18422.263109475603, 18457.907710461463, 975.2393133355994, 1003.9849402258972, 1008.9646862359818, 1009.1422291052584, 1009.3439264478075, 666.3569655282652, 994.4878387630376, 995.2635050062937, 995.3530205366534, 1011.2516737614186, 737.6827963975488, 1005.2360206243235, 1043.3896170740127, 1045.4302405189153, 1046.7016900183448, 1035.9119474844647, 1036.6009086501676, 1036.8133735927606, 1037.097724979269, 1043.5512729526301, 768.3968085053207, 769.1616138409161, 769.6036541181296, 772.2509166108865, 775.3332134364442, 15983.680326393524, 16343.26455309514, 16527.008379497147, 16543.503694889172, 16842.494725158263, 16593.83406165935, 16626.085565293903, 16823.158842057972, 17043.91478042614, 17101.31594736209, 13712.588622341345, 13911.721765564633, 13953.860461395358, 14055.226962517057, 14145.292735363191, 3425.554677891883, 3450.8274586270586, 3453.067671728644, 3455.809930453824, 3456.844442000116, 113436.4328178362, 114796.42601787021, 114883.42558287238, 114955.0, 115680.0, 12096.516139354504, 12208.32854193028, 12213.0, 12213.69465763363, 12224.0, 17105.486835394957, 17812.821871781118, 19100.2359905605, 24381.756182437948, 24382.146624868044, 7545.886811697719, 7603.163651998276, 7679.884801727867, 7735.419843511759, 7738.032745906762, 3948.506436695413, 4024.396340548941, 4036.6367026967127, 4038.7980600970423, 4044.3529035354204, 4152.91694166115, 4194.266003449384, 4215.768132752667, 4262.083652014831, 4266.658667306608, 883.4699180491782, 900.0909081827401, 909.9863502047475, 910.6266430763355, 911.7857303533664, 576.9624974376652, 652.4649787174471, 656.9408753212234, 673.3031312591444, 691.350130876974, 11096.891590597761, 11426.371549564687, 11642.6507204784, 11809.996150327319, 12049.578264760692, 588.7233000489763, 639.133973465947, 653.9771108011197, 654.4894981914115, 670.199112061092, 5022.296878437021, 5340.394245290539, 5391.245225668409, 5593.328800543879, 5668.26312579362, 95575.52212238894, 96798.0, 98824.01175988148, 99039.50480247552, 100866.0, 78446.21553784389, 78746.21253787504, 79645.60177199077, 87011.0, 89926.55036724775, 68465.65767171232, 69914.65042674856, 70431.0, 70835.93746093813, 71346.50861659554, 7448.8882666758955, 7877.172896845748, 9723.36798108149, 10001.449920254456, 10042.748931276776, 35213.119672008404, 38143.61856381401, 38182.85451436461, 38224.80887595656, 41033.589664102976, 59893.700531498806, 62430.687846560475, 63169.68415157895, 65629.67185164044, 66949.33050669431, 16369.181540923144, 16485.928414653008, 16489.175541223132, 16590.75113873269, 16848.0, 17609.29562817473, 17911.10444477797, 18261.995590242663, 18301.816981830012, 18346.422447622586, 16241.837581624504, 16409.58976025609, 16547.255373507982, 16576.917115414344, 16668.49994500167, 13782.93108534451, 16065.919670401574, 16229.0, 16347.34610615562, 16564.17179141014, 13585.660358491117, 15928.522144335688, 16000.439984600484, 16022.839771602135, 16034.278457469674, 11526.0, 11758.82361764557, 11861.40692965331, 11948.163628545919, 11985.400729963641, 11379.203455758348, 11600.0, 12795.808062878878, 12888.871111288767, 12946.0], "value": 8091.519138632672, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1434.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 109.0, 149.0, 109.0, 107.0, 108.0, 106.0, 138.0, 118.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 182.0, 183.0, 188.0, 184.0, 184.0, 185.0, 181.0, 186.0, 208.0], "value": 187.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 61.0, 63.0, 115.0, 84.0, 60.0, 60.0, 61.0, 86.0, 57.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 85.0, 71.0, 69.0, 69.0, 90.0, 68.0, 69.0, 90.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 88.0, 88.0, 87.0, 88.0, 87.0, 88.0, 89.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 86.0, 84.0, 83.0, 85.0, 88.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 50.0, 49.0, 50.0, 51.0, 48.0, 51.0, 49.0, 49.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 57.0, 65.0, 66.0, 59.0, 55.0, 58.0, 57.0, 57.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 86.0, 83.0, 81.0, 82.0, 83.0, 82.0, 82.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 143.0, 132.0, 137.0, 139.0, 135.0, 141.0, 126.0, 170.0, 148.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 187.0, 186.0, 208.0, 188.0, 187.0, 181.0, 219.0, 221.0, 181.0], "value": 194.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 66.0, 65.0, 68.0, 66.0, 84.0, 91.0, 90.0], "value": 73.3, "unit": "score"}]}]} 12:46:10 INFO - Return code: 0 12:46:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:46:10 ERROR - # TBPL SUCCESS # 12:46:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:46:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:46:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:46:10 INFO - 2017-04-15 12:46:10.702 screenresolution[1657:10521] starting screenresolution argv=screenresolution get 12:46:10 INFO - 2017-04-15 12:46:10.705 screenresolution[1657:10521] Display 0: 1600x1200x32@60 12:46:10 INFO - 2017-04-15 12:46:10.711 screenresolution[1658:10524] starting screenresolution argv=screenresolution list 12:46:10 INFO - Available Modes on Display 0 12:46:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:46:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:46:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:46:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:46:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:46:10 INFO - Intel Iris: 12:46:10 INFO - Chipset Model: Intel Iris 12:46:10 INFO - Type: GPU 12:46:10 INFO - Bus: Built-In 12:46:10 INFO - VRAM (Dynamic, Max): 1536 MB 12:46:10 INFO - Vendor: Intel (0x8086) 12:46:10 INFO - Device ID: 0x0a2e 12:46:10 INFO - Revision ID: 0x0009 12:46:10 INFO - Displays: 12:46:10 INFO - Display: 12:46:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:46:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:46:10 INFO - Display Serial Number: 1600x1200 60 12:46:10 INFO - Main Display: Yes 12:46:10 INFO - Mirror: Off 12:46:10 INFO - Online: Yes 12:46:10 INFO - Rotation: Supported 12:46:10 INFO - Return code: 0 12:46:10 INFO - Running post-action listener: _resource_record_post_action 12:46:10 INFO - [mozharness: 2017-04-15 19:46:10.946361Z] Finished run-tests step (success) 12:46:10 INFO - Running post-run listener: _resource_record_post_run 12:46:11 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 32910848; Write bytes: 515897344; Read time: 198; Write time: 1580 12:46:11 INFO - TinderboxPrint: CPU usage
53.4% 12:46:11 INFO - TinderboxPrint: I/O read bytes / time
32,910,848 / 198 12:46:11 INFO - TinderboxPrint: I/O write bytes / time
515,897,344 / 1,580 12:46:11 INFO - TinderboxPrint: CPU idle
2,238.9 (46.6%) 12:46:11 INFO - TinderboxPrint: CPU system
958.4 (19.9%) 12:46:11 INFO - TinderboxPrint: CPU user
1,608.4 (33.5%) 12:46:11 INFO - TinderboxPrint: Swap in / out
237,637,632 / 0 12:46:11 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207548928; Write bytes: 207344128; Read time: 16178; Write time: 434 12:46:11 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 29023744; Write bytes: 303489024; Read time: 173; Write time: 1124 12:46:11 INFO - Running post-run listener: _upload_blobber_files 12:46:11 INFO - Blob upload gear active. 12:46:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:46:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:46:11 INFO - (blobuploader) - INFO - Open directory for files ... 12:46:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:46:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:46:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:12 INFO - (blobuploader) - INFO - Done attempting. 12:46:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:46:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:13 INFO - (blobuploader) - INFO - Done attempting. 12:46:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:46:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:46:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:14 INFO - (blobuploader) - INFO - Done attempting. 12:46:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:46:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:46:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:16 INFO - (blobuploader) - INFO - Done attempting. 12:46:16 INFO - (blobuploader) - INFO - Iteration through files over. 12:46:16 INFO - Return code: 0 12:46:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:46:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:46:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83d090f6d6b6b398f66ca166f53f6e82db12c6a38f411ed6f37ad2c1027771bdefbcf3005e3ab4a640383638ddb15d87010ec401703b6cea207bf6956ea53926", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/983b42e238c5afed5f7274861ece8abb8acb3fd9431a193b3d9fa6ee893176a0525ce0dd5ec5ec0b74f2d6df0463a20c4ecacaa8a31870a8a7a1881733a6ae5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d80ac44f8221af517f678adedb94a4f663afbe77924511db29dd366654c01d4bff9e2a68982ecb74cb6576587b99bcfdc37af71f67d43835cdc1bd42c89e9de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cb4d2b886a778e50a2b8a3f48e083ecf636013534954fc1964bc48fe8d13e3a93e2febc45ef7a231ad00e5f832f3e797617647611c2e39a7cef3c0e1a71de0b"} 12:46:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:46:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:46:16 INFO - Contents: 12:46:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83d090f6d6b6b398f66ca166f53f6e82db12c6a38f411ed6f37ad2c1027771bdefbcf3005e3ab4a640383638ddb15d87010ec401703b6cea207bf6956ea53926", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/983b42e238c5afed5f7274861ece8abb8acb3fd9431a193b3d9fa6ee893176a0525ce0dd5ec5ec0b74f2d6df0463a20c4ecacaa8a31870a8a7a1881733a6ae5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d80ac44f8221af517f678adedb94a4f663afbe77924511db29dd366654c01d4bff9e2a68982ecb74cb6576587b99bcfdc37af71f67d43835cdc1bd42c89e9de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cb4d2b886a778e50a2b8a3f48e083ecf636013534954fc1964bc48fe8d13e3a93e2febc45ef7a231ad00e5f832f3e797617647611c2e39a7cef3c0e1a71de0b"} 12:46:16 INFO - Running post-run listener: copy_logs_to_upload_dir 12:46:16 INFO - Copying logs to upload dir... 12:46:16 INFO - mkdir: /builds/slave/test/build/upload/logs 12:46:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.259997 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-15 12:46:16.497327) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-15 12:46:16.500499) ========= 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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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/83d090f6d6b6b398f66ca166f53f6e82db12c6a38f411ed6f37ad2c1027771bdefbcf3005e3ab4a640383638ddb15d87010ec401703b6cea207bf6956ea53926", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/983b42e238c5afed5f7274861ece8abb8acb3fd9431a193b3d9fa6ee893176a0525ce0dd5ec5ec0b74f2d6df0463a20c4ecacaa8a31870a8a7a1881733a6ae5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d80ac44f8221af517f678adedb94a4f663afbe77924511db29dd366654c01d4bff9e2a68982ecb74cb6576587b99bcfdc37af71f67d43835cdc1bd42c89e9de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cb4d2b886a778e50a2b8a3f48e083ecf636013534954fc1964bc48fe8d13e3a93e2febc45ef7a231ad00e5f832f3e797617647611c2e39a7cef3c0e1a71de0b"} build_url:https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010991 build_url: 'https://queue.taskcluster.net/v1/task/Z1rAgAxMRZaXM2P8rB_YBg/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/83d090f6d6b6b398f66ca166f53f6e82db12c6a38f411ed6f37ad2c1027771bdefbcf3005e3ab4a640383638ddb15d87010ec401703b6cea207bf6956ea53926", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/983b42e238c5afed5f7274861ece8abb8acb3fd9431a193b3d9fa6ee893176a0525ce0dd5ec5ec0b74f2d6df0463a20c4ecacaa8a31870a8a7a1881733a6ae5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d80ac44f8221af517f678adedb94a4f663afbe77924511db29dd366654c01d4bff9e2a68982ecb74cb6576587b99bcfdc37af71f67d43835cdc1bd42c89e9de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cb4d2b886a778e50a2b8a3f48e083ecf636013534954fc1964bc48fe8d13e3a93e2febc45ef7a231ad00e5f832f3e797617647611c2e39a7cef3c0e1a71de0b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-15 12:46:16.534729) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 12:46:16.535048) ========= 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.vzSSEiJ2x1/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.MZUC8bIoSU/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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.004654 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 12:46:16.584019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-15 12:46:16.584358) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-15 12:46:16.584688) ========= ========= Total master_lag: 0.19 =========