builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0127 starttime: 1487790701.98 results: success (0) buildid: 20170222095021 builduid: 00a471d5c82e4600af848d6edcb74bb0 revision: 70eb26b3bee4ee2389688b71f8fa35b13ed63173 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 11:11:41.979393) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 11:11:41.979838) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 11:11:41.980103) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 11:11:42.005912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 11:11:42.006247) ========= 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.jOScjViRRT/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.LrBkfgrGoq/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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-02-22 11:11:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2017-02-22 11:11:42 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.158285 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 11:11:42.186787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 11:11:42.187140) ========= 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.jOScjViRRT/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.LrBkfgrGoq/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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.035393 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 11:11:42.244011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 11:11:42.244383) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 70eb26b3bee4ee2389688b71f8fa35b13ed63173 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 70eb26b3bee4ee2389688b71f8fa35b13ed63173 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jOScjViRRT/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.LrBkfgrGoq/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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-02-22 11:11:42,355 truncating revision to first 12 chars 2017-02-22 11:11:42,355 Setting DEBUG logging. 2017-02-22 11:11:42,355 attempt 1/10 2017-02-22 11:11:42,355 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/70eb26b3bee4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 11:11:43,305 unpacking tar archive at: mozilla-aurora-70eb26b3bee4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.228334 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 11:11:43.555805) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 11:11:43.556072) ========= script_repo_revision: 70eb26b3bee4ee2389688b71f8fa35b13ed63173 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 11:11:43.556460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 11:11:43.556737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 11:11:43.577818) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-22 11:11:43.578172) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jOScjViRRT/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.LrBkfgrGoq/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 11:11:43 INFO - MultiFileLogger online at 20170222 11:11:43 in /builds/slave/test 11:11:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:11:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:43 INFO - {'append_to_log': False, 11:11:43 INFO - 'base_work_dir': '/builds/slave/test', 11:11:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:11:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:43 INFO - 'branch': 'Mozilla-Aurora', 11:11:43 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:43 INFO - 'config_files': ('talos/mac_config.py',), 11:11:43 INFO - 'default_actions': ('clobber', 11:11:43 INFO - 'read-buildbot-config', 11:11:43 INFO - 'download-and-extract', 11:11:43 INFO - 'populate-webroot', 11:11:43 INFO - 'create-virtualenv', 11:11:43 INFO - 'install', 11:11:43 INFO - 'run-tests'), 11:11:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:43 INFO - 'download_minidump_stackwalk': True, 11:11:43 INFO - 'download_symbols': 'ondemand', 11:11:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:43 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:43 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:43 INFO - 'installer_path': 'installer.exe', 11:11:43 INFO - 'log_level': 'info', 11:11:43 INFO - 'log_name': 'talos', 11:11:43 INFO - 'log_to_console': True, 11:11:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:11:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:11:43 INFO - 'opt_config_files': (), 11:11:43 INFO - 'pip_index': False, 11:11:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:43 INFO - 'cmd': ('bash', 11:11:43 INFO - '-c', 11:11:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:43 INFO - 'enabled': True, 11:11:43 INFO - 'halt_on_failure': False, 11:11:43 INFO - 'name': 'check_screen_resolution'},), 11:11:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:43 INFO - 'cmd': ('bash', 11:11:43 INFO - '-c', 11:11:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:43 INFO - 'enabled': True, 11:11:43 INFO - 'halt_on_failure': False, 11:11:43 INFO - 'name': 'check_screen_resolution'},), 11:11:43 INFO - 'run_cmd_checks_enabled': True, 11:11:43 INFO - 'sps_profile': False, 11:11:43 INFO - 'sps_profile_interval': 0, 11:11:43 INFO - 'suite': 'dromaeojs', 11:11:43 INFO - 'system_bits': '32', 11:11:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:43 INFO - 'title': 't-yosemite-r7-0127', 11:11:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:43 INFO - 'use_talos_json': True, 11:11:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:43 INFO - 'work_dir': 'build'} 11:11:43 INFO - [mozharness: 2017-02-22 19:11:43.794932Z] Running clobber step. 11:11:43 INFO - Running pre-action listener: _resource_record_pre_action 11:11:43 INFO - Running main action method: clobber 11:11:43 INFO - rmtree: /builds/slave/test/build 11:11:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:46 INFO - Running post-action listener: _resource_record_post_action 11:11:46 INFO - [mozharness: 2017-02-22 19:11:46.433658Z] Finished clobber step (success) 11:11:46 INFO - [mozharness: 2017-02-22 19:11:46.433855Z] Running read-buildbot-config step. 11:11:46 INFO - Running pre-action listener: _resource_record_pre_action 11:11:46 INFO - Running main action method: read_buildbot_config 11:11:46 INFO - Using buildbot properties: 11:11:46 INFO - { 11:11:46 INFO - "project": "", 11:11:46 INFO - "product": "firefox", 11:11:46 INFO - "script_repo_revision": "production", 11:11:46 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:11:46 INFO - "repository": "", 11:11:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:11:46 INFO - "buildid": "20170222095021", 11:11:46 INFO - "pgo_build": "False", 11:11:46 INFO - "basedir": "/builds/slave/test", 11:11:46 INFO - "buildnumber": 10, 11:11:46 INFO - "slavename": "t-yosemite-r7-0127", 11:11:46 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:11:46 INFO - "platform": "yosemite_r7", 11:11:46 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:11:46 INFO - "branch": "mozilla-aurora", 11:11:46 INFO - "repo_path": "releases/mozilla-aurora", 11:11:46 INFO - "revision": "70eb26b3bee4ee2389688b71f8fa35b13ed63173", 11:11:46 INFO - "stage_platform": "macosx64", 11:11:46 INFO - "builduid": "00a471d5c82e4600af848d6edcb74bb0", 11:11:46 INFO - "slavebuilddir": "test" 11:11:46 INFO - } 11:11:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 11:11:46 INFO - Running post-action listener: _resource_record_post_action 11:11:46 INFO - [mozharness: 2017-02-22 19:11:46.437263Z] Finished read-buildbot-config step (success) 11:11:46 INFO - [mozharness: 2017-02-22 19:11:46.437402Z] Running download-and-extract step. 11:11:46 INFO - Running pre-action listener: _resource_record_pre_action 11:11:46 INFO - Running main action method: download_and_extract 11:11:46 INFO - mkdir: /builds/slave/test/build/tests 11:11: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')]} 11:11:46 INFO - trying https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 11:11:46 INFO - Downloading https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 11:11:47 INFO - Downloaded 1199 bytes. 11:11:47 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:11:47 INFO - Using the following test package requirements: 11:11:47 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:11:47 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:11:47 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 11:11:47 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:11:47 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 11:11:47 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:11:47 INFO - u'jsshell-mac.zip'], 11:11:47 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:11:47 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 11:11:47 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:11:47 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:11:47 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 11:11:47 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:11:47 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 11:11:47 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:11:47 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 11:11:47 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:11:47 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 11:11:47 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:11:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:11:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:11:47 INFO - Fetch https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:11:48 INFO - Expected file size: 16357547 11:11:48 INFO - Obtained file size: 16357547 11:11:55 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:11:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:11:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:11:55 INFO - Fetch https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:11:56 INFO - Expected file size: 16357547 11:11:56 INFO - Obtained file size: 16357547 11:12:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 11:12:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:12:02 INFO - Fetch https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 11:12:03 INFO - Expected file size: 14403485 11:12:03 INFO - Obtained file size: 14403485 11:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:03 INFO - trying https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:12:03 INFO - Downloading https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 11:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 11:12:06 INFO - Downloaded 73931890 bytes. 11:12:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:12:06 INFO - mkdir: /builds/slave/test/properties 11:12:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:06 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:06 INFO - Contents: 11:12:06 INFO - build_url:https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:12:06 INFO - Running post-action listener: _resource_record_post_action 11:12:06 INFO - Running post-action listener: set_extra_try_arguments 11:12:06 INFO - [mozharness: 2017-02-22 19:12:06.694348Z] Finished download-and-extract step (success) 11:12:06 INFO - [mozharness: 2017-02-22 19:12:06.694503Z] Running populate-webroot step. 11:12:06 INFO - Running pre-action listener: _resource_record_pre_action 11:12:06 INFO - Running main action method: populate_webroot 11:12:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:06 INFO - '--tppagecycles', 11:12:06 INFO - '7'], 11:12:06 INFO - 'tests': ['tsvgm']}}, 11:12:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:12:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:12:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:12:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:12:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:12:06 INFO - 'talos_options': ['--disable-e10s'], 11:12:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:12:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:12:06 INFO - 'talos_options': ['--disable-e10s'], 11:12:06 INFO - 'tests': ['damp', 'tps']}, 11:12:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:12:06 INFO - 'tests': ['damp', 'tps']}, 11:12:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:12:06 INFO - 'tests': ['dromaeo_dom']}, 11:12:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:12:06 INFO - 'tests': ['basic_compositor_video']}, 11:12:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:12:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:12:06 INFO - 'tests': ['a11yr', 11:12:06 INFO - 'ts_paint', 11:12:06 INFO - 'tpaint', 11:12:06 INFO - 'sessionrestore', 11:12:06 INFO - 'sessionrestore_no_auto_restore', 11:12:06 INFO - 'tabpaint']}, 11:12:06 INFO - 'other-e10s': {'tests': ['a11yr', 11:12:06 INFO - 'ts_paint', 11:12:06 INFO - 'tpaint', 11:12:06 INFO - 'sessionrestore', 11:12:06 INFO - 'sessionrestore_no_auto_restore', 11:12:06 INFO - 'tabpaint']}, 11:12:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:12:06 INFO - 'ts_paint', 11:12:06 INFO - 'tpaint', 11:12:06 INFO - 'sessionrestore', 11:12:06 INFO - 'sessionrestore_no_auto_restore', 11:12:06 INFO - 'tabpaint']}, 11:12:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:12:06 INFO - 'ts_paint', 11:12:06 INFO - 'tpaint', 11:12:06 INFO - 'sessionrestore', 11:12:06 INFO - 'sessionrestore_no_auto_restore', 11:12:06 INFO - 'tabpaint']}, 11:12:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:12:06 INFO - 'tests': ['a11yr', 11:12:06 INFO - 'ts_paint', 11:12:06 INFO - 'tpaint', 11:12:06 INFO - 'sessionrestore', 11:12:06 INFO - 'sessionrestore_no_auto_restore', 11:12:06 INFO - 'tabpaint']}, 11:12:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:12:06 INFO - 'tests': ['a11yr', 11:12:06 INFO - 'ts_paint', 11:12:06 INFO - 'tpaint', 11:12:06 INFO - 'sessionrestore', 11:12:06 INFO - 'sessionrestore_no_auto_restore', 11:12:06 INFO - 'tabpaint']}, 11:12:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:12:06 INFO - 'tests': ['tsvgx', 11:12:06 INFO - 'tsvgr_opacity', 11:12:06 INFO - 'tart', 11:12:06 INFO - 'tscrollx', 11:12:06 INFO - 'cart', 11:12:06 INFO - 'tsvg_static']}, 11:12:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:12:06 INFO - 'tsvgr_opacity', 11:12:06 INFO - 'tart', 11:12:06 INFO - 'tscrollx', 11:12:06 INFO - 'cart', 11:12:06 INFO - 'tsvg_static']}, 11:12:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:12:06 INFO - 'talos_options': ['--disable-e10s'], 11:12:06 INFO - 'tests': ['tp5o']}, 11:12:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:12:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:12:06 INFO - 'talos_options': ['--disable-e10s', 11:12:06 INFO - '--xperf_path', 11:12:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:06 INFO - 'tests': ['tp5n']}, 11:12:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:12:06 INFO - 'talos_options': ['--xperf_path', 11:12:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:06 INFO - 'tests': ['tp5n']}}, 11:12:06 INFO - 'talos.zip': {'path': '', 11:12:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:06 INFO - Running post-action listener: _resource_record_post_action 11:12:06 INFO - [mozharness: 2017-02-22 19:12:06.712923Z] Finished populate-webroot step (success) 11:12:06 INFO - [mozharness: 2017-02-22 19:12:06.713028Z] Running create-virtualenv step. 11:12:06 INFO - Running pre-action listener: _resource_record_pre_action 11:12:06 INFO - Running main action method: create_virtualenv 11:12:06 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:06 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 11:12:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:12:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:06 INFO - Using real prefix '/tools/python27' 11:12:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:07 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:10 INFO - Installing pip.................done. 11:12:10 INFO - Return code: 0 11:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:12:10 INFO - Reading from file tmpfile_stdout 11:12:10 INFO - Output received: 11:12:10 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) 11:12:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aa7fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa82768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342caaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85dd30>, '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 0x10a784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a852be8>, '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.jOScjViRRT/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.LrBkfgrGoq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 11:12:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:12:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jOScjViRRT/Render', 11:12:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:10 INFO - 'HOME': '/Users/cltbld', 11:12:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:10 INFO - 'LOGNAME': 'cltbld', 11:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:10 INFO - 'MOZ_NO_REMOTE': '1', 11:12:10 INFO - 'NO_EM_RESTART': '1', 11:12:10 INFO - 'PAGER': '/bin/cat', 11:12:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:10 INFO - 'PWD': '/builds/slave/test', 11:12:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:10 INFO - 'SHELL': '/bin/bash', 11:12:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LrBkfgrGoq/Listeners', 11:12:10 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 11:12:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:10 INFO - 'USER': 'cltbld', 11:12:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:10 INFO - 'XPC_FLAGS': '0x0', 11:12:10 INFO - 'XPC_SERVICE_NAME': '0', 11:12:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:10 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 11:12:10 INFO - Cleaning up... 11:12:10 INFO - Return code: 0 11:12:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aa7fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa82768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342caaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85dd30>, '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 0x10a784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a852be8>, '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.jOScjViRRT/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.LrBkfgrGoq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 11:12:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:12:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jOScjViRRT/Render', 11:12:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:10 INFO - 'HOME': '/Users/cltbld', 11:12:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:10 INFO - 'LOGNAME': 'cltbld', 11:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:10 INFO - 'MOZ_NO_REMOTE': '1', 11:12:10 INFO - 'NO_EM_RESTART': '1', 11:12:10 INFO - 'PAGER': '/bin/cat', 11:12:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:10 INFO - 'PWD': '/builds/slave/test', 11:12:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:10 INFO - 'SHELL': '/bin/bash', 11:12:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LrBkfgrGoq/Listeners', 11:12:10 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 11:12:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:10 INFO - 'USER': 'cltbld', 11:12:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:10 INFO - 'XPC_FLAGS': '0x0', 11:12:10 INFO - 'XPC_SERVICE_NAME': '0', 11:12:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:11 INFO - Downloading/unpacking psutil>=3.1.1 11:12:11 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 11:12:11 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 11:12:11 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 11:12:11 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 11:12:11 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 11:12:11 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 11:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:14 INFO - Installing collected packages: psutil 11:12:14 INFO - Running setup.py install for psutil 11:12:14 INFO - building 'psutil._psutil_osx' extension 11:12:14 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 11:12:15 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 11:12:15 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 11:12:15 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 11:12:15 INFO - building 'psutil._psutil_posix' extension 11:12:15 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 11:12:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:12:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:12:15 INFO - ^ 11:12:15 INFO - 1 warning generated. 11:12:15 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 11:12:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:15 INFO - Successfully installed psutil 11:12:15 INFO - Cleaning up... 11:12:15 INFO - Return code: 0 11:12:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:12:15 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')]} 11:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:15 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')]} 11:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:15 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 0x10aa7fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa82768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342caaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85dd30>, '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 0x10a784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a852be8>, '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.jOScjViRRT/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.LrBkfgrGoq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 11:12:15 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 11:12:15 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 11:12:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jOScjViRRT/Render', 11:12:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:15 INFO - 'HOME': '/Users/cltbld', 11:12:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:15 INFO - 'LOGNAME': 'cltbld', 11:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:15 INFO - 'MOZ_NO_REMOTE': '1', 11:12:15 INFO - 'NO_EM_RESTART': '1', 11:12:15 INFO - 'PAGER': '/bin/cat', 11:12:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:15 INFO - 'PWD': '/builds/slave/test', 11:12:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:15 INFO - 'SHELL': '/bin/bash', 11:12:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LrBkfgrGoq/Listeners', 11:12:15 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 11:12:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:15 INFO - 'USER': 'cltbld', 11:12:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:15 INFO - 'XPC_FLAGS': '0x0', 11:12:15 INFO - 'XPC_SERVICE_NAME': '0', 11:12:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:12:16 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 11:12:16 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 11:12:16 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 11:12:16 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 11:12:16 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 11:12:16 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 11:12:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:12:18 INFO - Installing collected packages: mozsystemmonitor 11:12:18 INFO - Running setup.py install for mozsystemmonitor 11:12:19 INFO - Successfully installed mozsystemmonitor 11:12:19 INFO - Cleaning up... 11:12:19 INFO - Return code: 0 11:12:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:19 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 0x10aa7fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa82768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342caaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85dd30>, '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 0x10a784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a852be8>, '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.jOScjViRRT/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.LrBkfgrGoq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 11:12:19 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 11:12:19 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 11:12:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jOScjViRRT/Render', 11:12:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:19 INFO - 'HOME': '/Users/cltbld', 11:12:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:19 INFO - 'LOGNAME': 'cltbld', 11:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:19 INFO - 'MOZ_NO_REMOTE': '1', 11:12:19 INFO - 'NO_EM_RESTART': '1', 11:12:19 INFO - 'PAGER': '/bin/cat', 11:12:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:19 INFO - 'PWD': '/builds/slave/test', 11:12:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:19 INFO - 'SHELL': '/bin/bash', 11:12:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LrBkfgrGoq/Listeners', 11:12:19 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 11:12:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:19 INFO - 'USER': 'cltbld', 11:12:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:19 INFO - 'XPC_FLAGS': '0x0', 11:12:19 INFO - 'XPC_SERVICE_NAME': '0', 11:12:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:19 INFO - Downloading/unpacking jsonschema==2.5.1 11:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:12:22 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 11:12:22 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 11:12:22 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 11:12:22 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 11:12:22 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 11:12:22 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 11:12:22 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:22 INFO - warning: no files found matching '*.txt' 11:12:22 INFO - no previously-included directories found matching 'build' 11:12:22 INFO - no previously-included directories found matching 'dist' 11:12:22 INFO - no previously-included directories found matching '.git*' 11:12:22 INFO - Installing collected packages: jsonschema, functools32 11:12:22 INFO - Running setup.py install for functools32 11:12:22 INFO - warning: no files found matching '*.txt' 11:12:22 INFO - no previously-included directories found matching 'build' 11:12:22 INFO - no previously-included directories found matching 'dist' 11:12:22 INFO - no previously-included directories found matching '.git*' 11:12:22 INFO - Successfully installed jsonschema functools32 11:12:22 INFO - Cleaning up... 11:12:22 INFO - Return code: 0 11:12:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:22 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 0x10aa7fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa82768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342caaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85dd30>, '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 0x10a784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a852be8>, '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.jOScjViRRT/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.LrBkfgrGoq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 11:12:22 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 11:12:22 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 11:12:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jOScjViRRT/Render', 11:12:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:22 INFO - 'HOME': '/Users/cltbld', 11:12:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:22 INFO - 'LOGNAME': 'cltbld', 11:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:22 INFO - 'MOZ_NO_REMOTE': '1', 11:12:22 INFO - 'NO_EM_RESTART': '1', 11:12:22 INFO - 'PAGER': '/bin/cat', 11:12:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:22 INFO - 'PWD': '/builds/slave/test', 11:12:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:22 INFO - 'SHELL': '/bin/bash', 11:12:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LrBkfgrGoq/Listeners', 11:12:22 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 11:12:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:22 INFO - 'USER': 'cltbld', 11:12:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:22 INFO - 'XPC_FLAGS': '0x0', 11:12:22 INFO - 'XPC_SERVICE_NAME': '0', 11:12:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:12:23 INFO - Cleaning up... 11:12:23 INFO - Return code: 0 11:12:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:23 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 0x10aa7fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa82768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342caaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85dd30>, '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 0x10a784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a852be8>, '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.jOScjViRRT/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.LrBkfgrGoq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 11:12:23 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 11:12:23 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 11:12:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jOScjViRRT/Render', 11:12:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:23 INFO - 'HOME': '/Users/cltbld', 11:12:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:23 INFO - 'LOGNAME': 'cltbld', 11:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:23 INFO - 'MOZ_NO_REMOTE': '1', 11:12:23 INFO - 'NO_EM_RESTART': '1', 11:12:23 INFO - 'PAGER': '/bin/cat', 11:12:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:23 INFO - 'PWD': '/builds/slave/test', 11:12:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:23 INFO - 'SHELL': '/bin/bash', 11:12:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LrBkfgrGoq/Listeners', 11:12:23 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 11:12:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:23 INFO - 'USER': 'cltbld', 11:12:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:23 INFO - 'XPC_FLAGS': '0x0', 11:12:23 INFO - 'XPC_SERVICE_NAME': '0', 11:12:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:23 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:23 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 11:12:23 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 11:12:23 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 11:12:23 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 11:12:23 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 11:12:23 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 11:12:26 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:27 INFO - Downloading docopt-0.6.1.tar.gz 11:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:27 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:27 INFO - Running setup.py install for blobuploader 11:12:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:27 INFO - Running setup.py install for requests 11:12:28 INFO - Running setup.py install for docopt 11:12:28 INFO - Successfully installed blobuploader requests docopt 11:12:28 INFO - Cleaning up... 11:12:28 INFO - Return code: 0 11:12:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:28 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 0x10aa7fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa82768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342caaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85dd30>, '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 0x10a784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a852be8>, '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.jOScjViRRT/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.LrBkfgrGoq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 11:12:28 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 11:12:28 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 11:12:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jOScjViRRT/Render', 11:12:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:28 INFO - 'HOME': '/Users/cltbld', 11:12:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:28 INFO - 'LOGNAME': 'cltbld', 11:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:28 INFO - 'MOZ_NO_REMOTE': '1', 11:12:28 INFO - 'NO_EM_RESTART': '1', 11:12:28 INFO - 'PAGER': '/bin/cat', 11:12:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:28 INFO - 'PWD': '/builds/slave/test', 11:12:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:28 INFO - 'SHELL': '/bin/bash', 11:12:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LrBkfgrGoq/Listeners', 11:12:28 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 11:12:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:28 INFO - 'USER': 'cltbld', 11:12:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:28 INFO - 'XPC_FLAGS': '0x0', 11:12:28 INFO - 'XPC_SERVICE_NAME': '0', 11:12:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:28 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-3qu3w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:28 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-vcDcrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:28 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-2ZWbgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:28 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-TYNx4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:28 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-mzawrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:29 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-6vEyBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:29 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-C07gL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:29 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-LNB_zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:29 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-Rm0oOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:29 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-kGHcAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:29 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-fuBLCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:29 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-UO7AxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:29 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-I2_6af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:29 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-qiNe5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:29 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-MslDzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:30 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-y7OWBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:30 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-cMuESF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:30 INFO - Running setup.py install for manifestparser 11:12:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:30 INFO - Running setup.py install for mozcrash 11:12:30 INFO - Running setup.py install for mozdebug 11:12:30 INFO - Running setup.py install for mozdevice 11:12:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:12:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:30 INFO - Running setup.py install for mozfile 11:12:31 INFO - Running setup.py install for mozhttpd 11:12:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:31 INFO - Running setup.py install for mozinfo 11:12:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:31 INFO - Running setup.py install for mozInstall 11:12:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:31 INFO - Running setup.py install for mozleak 11:12:31 INFO - Running setup.py install for mozlog 11:12:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:31 INFO - Running setup.py install for moznetwork 11:12:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:31 INFO - Running setup.py install for mozprocess 11:12:32 INFO - Running setup.py install for mozprofile 11:12:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:32 INFO - Running setup.py install for mozrunner 11:12:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:12:32 INFO - Running setup.py install for mozscreenshot 11:12:32 INFO - Running setup.py install for moztest 11:12:32 INFO - Running setup.py install for mozversion 11:12:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:12:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:32 INFO - Cleaning up... 11:12:32 INFO - Return code: 0 11:12:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:32 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 0x10aa7fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa82768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342caaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85dd30>, '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 0x10a784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a852be8>, '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.jOScjViRRT/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.LrBkfgrGoq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 11:12:32 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 11:12:32 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 11:12:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jOScjViRRT/Render', 11:12:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:32 INFO - 'HOME': '/Users/cltbld', 11:12:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:32 INFO - 'LOGNAME': 'cltbld', 11:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:32 INFO - 'MOZ_NO_REMOTE': '1', 11:12:32 INFO - 'NO_EM_RESTART': '1', 11:12:32 INFO - 'PAGER': '/bin/cat', 11:12:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:32 INFO - 'PWD': '/builds/slave/test', 11:12:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:32 INFO - 'SHELL': '/bin/bash', 11:12:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LrBkfgrGoq/Listeners', 11:12:32 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 11:12:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:32 INFO - 'USER': 'cltbld', 11:12:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:32 INFO - 'XPC_FLAGS': '0x0', 11:12:32 INFO - 'XPC_SERVICE_NAME': '0', 11:12:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:33 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-e1cRro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:33 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)) 11:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:33 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-TlXRYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:33 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)) 11:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:33 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-3D0oHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:33 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)) 11:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:33 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-N9xwae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:33 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-DW7yPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:33 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)) 11:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:33 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-J_5U0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:33 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)) 11:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:33 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-yxfGtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:33 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)) 11:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:33 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-3nCrwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:33 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)) 11:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:33 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-UZg9Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:34 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)) 11:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:34 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-jbyHXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:34 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)) 11:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:34 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-lC0966-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:34 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)) 11:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:34 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-sFq_0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:34 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-5hXK2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:34 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)) 11:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:34 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-y725GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:34 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)) 11:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:34 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-myCMG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:34 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)) 11:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:34 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-p_QIGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:34 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)) 11:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:34 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-o5AYpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:34 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)) 11:12:34 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)) 11:12:34 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)) 11:12:34 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)) 11:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:34 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 11:12:34 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 11:12:34 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 11:12:34 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 11:12:34 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 11:12:34 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 11:12:37 INFO - Downloading blessings-1.6.tar.gz 11:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:37 INFO - Installing collected packages: blessings 11:12:37 INFO - Running setup.py install for blessings 11:12:37 INFO - Successfully installed blessings 11:12:37 INFO - Cleaning up... 11:12:37 INFO - Return code: 0 11:12:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:38 INFO - Reading from file tmpfile_stdout 11:12:38 INFO - Current package versions: 11:12:38 INFO - blessings == 1.6 11:12:38 INFO - blobuploader == 1.2.4 11:12:38 INFO - docopt == 0.6.1 11:12:38 INFO - functools32 == 3.2.3-2 11:12:38 INFO - jsonschema == 2.5.1 11:12:38 INFO - manifestparser == 1.1 11:12:38 INFO - mozInstall == 1.12 11:12:38 INFO - mozcrash == 1.0 11:12:38 INFO - mozdebug == 0.1 11:12:38 INFO - mozdevice == 0.49 11:12:38 INFO - mozfile == 1.2 11:12:38 INFO - mozhttpd == 0.7 11:12:38 INFO - mozinfo == 0.9 11:12:38 INFO - mozleak == 0.1 11:12:38 INFO - mozlog == 3.4 11:12:38 INFO - moznetwork == 0.27 11:12:38 INFO - mozprocess == 0.24 11:12:38 INFO - mozprofile == 0.28 11:12:38 INFO - mozrunner == 6.13 11:12:38 INFO - mozscreenshot == 0.1 11:12:38 INFO - mozsystemmonitor == 0.3 11:12:38 INFO - moztest == 0.8 11:12:38 INFO - mozversion == 1.4 11:12:38 INFO - psutil == 3.1.1 11:12:38 INFO - requests == 1.2.3 11:12:38 INFO - wsgiref == 0.1.2 11:12:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:38 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')]} 11:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:38 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')]} 11:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:38 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 0x10aa7fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa82768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342caaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85dd30>, '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 0x10a784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a852be8>, '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.jOScjViRRT/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.LrBkfgrGoq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 11:12:38 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 11:12:38 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 11:12:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jOScjViRRT/Render', 11:12:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:38 INFO - 'HOME': '/Users/cltbld', 11:12:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:38 INFO - 'LOGNAME': 'cltbld', 11:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:38 INFO - 'MOZ_NO_REMOTE': '1', 11:12:38 INFO - 'NO_EM_RESTART': '1', 11:12:38 INFO - 'PAGER': '/bin/cat', 11:12:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:38 INFO - 'PWD': '/builds/slave/test', 11:12:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:38 INFO - 'SHELL': '/bin/bash', 11:12:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LrBkfgrGoq/Listeners', 11:12:38 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 11:12:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:38 INFO - 'USER': 'cltbld', 11:12:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:38 INFO - 'XPC_FLAGS': '0x0', 11:12:38 INFO - 'XPC_SERVICE_NAME': '0', 11:12:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:38 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)) 11:12:38 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)) 11:12:38 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)) 11:12:38 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)) 11:12:38 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)) 11:12:38 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)) 11:12:38 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)) 11:12:38 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)) 11:12:38 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)) 11:12:38 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)) 11:12:38 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)) 11:12:38 INFO - Cleaning up... 11:12:38 INFO - Return code: 0 11:12:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12:38 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')]} 11:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:38 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')]} 11:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:38 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 0x10aa7fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa82768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa342caaa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85dd30>, '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 0x10a784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a852be8>, '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.jOScjViRRT/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.LrBkfgrGoq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 11:12:38 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 11:12:38 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 11:12:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jOScjViRRT/Render', 11:12:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:38 INFO - 'HOME': '/Users/cltbld', 11:12:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:38 INFO - 'LOGNAME': 'cltbld', 11:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:38 INFO - 'MOZ_NO_REMOTE': '1', 11:12:38 INFO - 'NO_EM_RESTART': '1', 11:12:38 INFO - 'PAGER': '/bin/cat', 11:12:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:38 INFO - 'PWD': '/builds/slave/test', 11:12:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:38 INFO - 'SHELL': '/bin/bash', 11:12:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LrBkfgrGoq/Listeners', 11:12:38 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 11:12:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:38 INFO - 'USER': 'cltbld', 11:12:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:38 INFO - 'XPC_FLAGS': '0x0', 11:12:38 INFO - 'XPC_SERVICE_NAME': '0', 11:12:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:12:38 INFO - Cleaning up... 11:12:38 INFO - Return code: 0 11:12:38 INFO - Running post-action listener: _resource_record_post_action 11:12:38 INFO - Running post-action listener: _start_resource_monitoring 11:12:38 INFO - Starting resource monitoring. 11:12:38 INFO - [mozharness: 2017-02-22 19:12:38.775358Z] Finished create-virtualenv step (success) 11:12:38 INFO - [mozharness: 2017-02-22 19:12:38.776272Z] Running install step. 11:12:38 INFO - Running pre-action listener: _resource_record_pre_action 11:12:38 INFO - Running main action method: install 11:12:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:39 INFO - Reading from file tmpfile_stdout 11:12:39 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:12:39 INFO - Reading from file tmpfile_stdout 11:12:39 INFO - Output received: 11:12:39 INFO - Usage: mozinstall [options] installer 11:12:39 INFO - Options: 11:12:39 INFO - -h, --help show this help message and exit 11:12:39 INFO - -d DEST, --destination=DEST 11:12:39 INFO - Directory to install application into. [default: 11:12:39 INFO - "/builds/slave/test"] 11:12:39 INFO - --app=APP Application being installed. [default: firefox] 11:12:39 INFO - mkdir: /builds/slave/test/build/application 11:12:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:12:59 INFO - Reading from file tmpfile_stdout 11:12:59 INFO - Output received: 11:12:59 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:12:59 INFO - Running post-action listener: _resource_record_post_action 11:12:59 INFO - [mozharness: 2017-02-22 19:12:59.468338Z] Finished install step (success) 11:12:59 INFO - [mozharness: 2017-02-22 19:12:59.468499Z] Running run-tests step. 11:12:59 INFO - Running pre-action listener: _resource_record_pre_action 11:12:59 INFO - Running main action method: run_tests 11:12:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:12:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:12:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:12:59 INFO - 2017-02-22 11:12:59.482 screenresolution[1618:7339] starting screenresolution argv=screenresolution get 11:12:59 INFO - 2017-02-22 11:12:59.485 screenresolution[1618:7339] Display 0: 1600x1200x32@60 11:12:59 INFO - 2017-02-22 11:12:59.491 screenresolution[1619:7342] starting screenresolution argv=screenresolution list 11:12:59 INFO - Available Modes on Display 0 11:12:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:12:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:12:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:12:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:12:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:12:59 INFO - Intel Iris: 11:12:59 INFO - Chipset Model: Intel Iris 11:12:59 INFO - Type: GPU 11:12:59 INFO - Bus: Built-In 11:12:59 INFO - VRAM (Dynamic, Max): 1536 MB 11:12:59 INFO - Vendor: Intel (0x8086) 11:12:59 INFO - Device ID: 0x0a2e 11:12:59 INFO - Revision ID: 0x0009 11:12:59 INFO - Displays: 11:12:59 INFO - Display: 11:12:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:12:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:12:59 INFO - Display Serial Number: 1600x1200 60 11:12:59 INFO - Main Display: Yes 11:12:59 INFO - Mirror: Off 11:12:59 INFO - Online: Yes 11:12:59 INFO - Rotation: Supported 11:12:59 INFO - Return code: 0 11:12:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:12:59 INFO - Python 2.7.3 11:12:59 INFO - Return code: 0 11:12:59 INFO - grabbing minidump binary from tooltool 11:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:59 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 0x10a85dd30>, '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 0x10a784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a852be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:12:59 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 11:12:59 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 11:12:59 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 11:12:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:59 INFO - Return code: 0 11:12:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:12:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:12:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:12:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:12:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:12:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0127', '--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 11:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0127 --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 11:12:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jOScjViRRT/Render', 11:12:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:59 INFO - 'HOME': '/Users/cltbld', 11:12:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:59 INFO - 'LOGNAME': 'cltbld', 11:12:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:59 INFO - 'MOZ_NO_REMOTE': '1', 11:12:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:59 INFO - 'NO_EM_RESTART': '1', 11:12:59 INFO - 'PAGER': '/bin/cat', 11:12:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:59 INFO - 'PWD': '/builds/slave/test', 11:12:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:59 INFO - 'SHELL': '/bin/bash', 11:12:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LrBkfgrGoq/Listeners', 11:12:59 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 11:12:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:59 INFO - 'USER': 'cltbld', 11:12:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:59 INFO - 'XPC_FLAGS': '0x0', 11:12:59 INFO - 'XPC_SERVICE_NAME': '0', 11:12:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0127', '--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 11:13:00 INFO - mozversion application_buildid: 20170222095021 11:13:00 INFO - mozversion application_changeset: 70eb26b3bee4ee2389688b71f8fa35b13ed63173 11:13:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:13:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:00 INFO - mozversion application_name: Firefox 11:13:00 INFO - mozversion application_remotingname: firefox-dev 11:13:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:13:00 INFO - mozversion application_vendor: Mozilla 11:13:00 INFO - mozversion application_version: 53.0a2 11:13:00 INFO - mozversion platform_buildid: 20170222095021 11:13:00 INFO - mozversion platform_changeset: 70eb26b3bee4ee2389688b71f8fa35b13ed63173 11:13:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:13:00 INFO - mozversion platform_version: 53.0a2 11:13:00 INFO - using testdate: 1487790780 11:13:00 INFO - actual date: 1487790780 11:13:00 INFO - starting webserver on 'localhost:49236' 11:13:00 INFO - SUITE-START | Running 2 tests 11:13:00 INFO - TEST-START | dromaeo_css 11:13:00 INFO - operating with platform_type : mac_ 11:13:00 INFO - Initialising browser for dromaeo_css test... 11:13:00 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpbSaeP9/profile http://localhost:49236/getInfo.html) 11:13:02 INFO - PROCESS | 1629 | __metrics Screen width/height:1600/1200 11:13:02 INFO - PROCESS | 1629 | colorDepth:24 11:13:02 INFO - PROCESS | 1629 | Browser inner width/height: 1024/689 11:13:02 INFO - PROCESS | 1629 | __metrics 11:13:02 INFO - PROCESS | 1629 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:13:02 INFO - PROCESS | 1629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:13:03 INFO - TEST-INFO | 1629: exit 0 11:13:03 INFO - Browser initialized. 11:13:03 INFO - Running cycle 1/1 for dromaeo_css test... 11:13:03 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpbSaeP9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:15 INFO - PROCESS | 1631 | RSS: Main: 213065728 11:13:15 INFO - PROCESS | 1631 | 11:16:18 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 11:16:20 INFO - PROCESS | 1631 | RSS: Main: 377466880 11:16:20 INFO - PROCESS | 1631 | 11:18:05 INFO - PROCESS | 1631 | ************************* 11:18:05 INFO - PROCESS | 1631 | A coding exception was thrown and uncaught in a Task. 11:18:05 INFO - PROCESS | 1631 | 11:18:05 ERROR - PROCESS | 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:18:05 INFO - PROCESS | 1631 | Full stack: 11:18:05 INFO - PROCESS | 1631 | ************************* 11:19:23 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 11:19:24 INFO - PROCESS | 1631 | RSS: Main: 355966976 11:19:24 INFO - PROCESS | 1631 | 11:22:26 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 11:22:27 INFO - PROCESS | 1631 | RSS: Main: 327053312 11:22:27 INFO - PROCESS | 1631 | 11:25:30 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 11:25:30 INFO - PROCESS | 1631 | RSS: Main: 350334976 11:25:30 INFO - PROCESS | 1631 | 11:28:34 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 11:28:34 INFO - PROCESS | 1631 | RSS: Main: 318799872 11:28:34 INFO - PROCESS | 1631 | 11:31:37 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 11:31:37 INFO - PROCESS | 1631 | RSS: Main: 532013056 11:31:37 INFO - PROCESS | 1631 | 11:31:37 INFO - PROCESS | 1631 | __start_tp_report 11:31:37 INFO - PROCESS | 1631 | _x_x_mozilla_page_load 11:31:37 INFO - PROCESS | 1631 | _x_x_mozilla_page_load_details 11:31:37 INFO - PROCESS | 1631 | |i|pagename|runs| 11:31:37 INFO - PROCESS | 1631 | |0;dojo.html;3346.949795753064;3363.4114030044734;3366.8148251846155;3378.341223461426;3421.70915472185;5590.385057643661;5619;5634.295713035871;5643.717814109299;5648;5562.499375056244;5570.86072848179;5621.241132447119;5624.072028115366;5627.859303517414;5148.459411761767;5151.021305951876;5165.096108181072;5172.612054095939;5217.087009773293;5136.614753893473;5161.329027226455;5225.294585230983;5262.473752624726;5278.894422111555;3937;4783.569478746912;5165.121929272014;5180;5279.498447647467;5187.818426355078;5254.054270231338;5269.604779641504;5274.2879711238875;5275.841724748264;4976.62675299354;5172.922406163911;5177.922331165036;5206.427292997767;5222.190560463135;5520.171974203861;5539.224508568804;5548.86127846803;5576.163575463673;5632.549396048306;6138.815835524942;6149.200603921507;6175.629462232236;6177.7837775677635;6177.876442471171;6185.041318595625;6240.469560087398;6247.562670613059;6268.65522396268;6269.498440124779;5595.888082238333;5653.8586535336535;5667.234923285386;5719.313682358102;5766.336871259775;6272.686365681698;6313.40022697843;6328.6519241442165;6341.651209183539;6357.268914074848;6169.81490555284;6181.938180618136;6193.102000209944;6194.225721784777;6202.627842329474;6235.812925612239;6273.937260627426;6278.591891527036;6295.779647712308;6306.716197771111;6014.6391216527145;6048.879022419527;6060.363661815446;6116.771101367247;6213.068039794067;6119.015143218386;6166.938330616636;6180.227471566054;6250.499960003189;6260.968695156586;4951.8266860659705;4977.875553111201;4990.4011518618;4999.775010124553;5035.874103147377;3929.980350098231;4433.401490798701;4459.063596644741;4464.933026004613;4471.195184866755;5602;5647;5653.689047102449;5726.141078838207;5767.163761254678;6250.406211409909;6283.874322513616;6294.968525157345;6300.558960872695;6302.873942521215;5743.62666426681;5782.421757824184;5798.739056742456;5805.593608447368;5830.183774271605;5295.523402893758;5377.946220537823;5384.865378365494;5411.810586629449;5466.398696143421;6319.715612797343;6380.298167201697;6424;6424.775132870327;6429.967850160906;6270.184875966095;6298.496120310272;6303.590266632654;6311.747530098744;6313.210848643919;6190.102435146969;6308.779192728232;6340.334264902303;6374.362563743589;6391.169148010729;6106.612350340234;6227.408396202353;6227.688615569294;6234.2830574484515;6259.65571893532;6122.142899994094;6247.5939063960695;6302.054691796084;6326.557141000086;6328.683565821782;5907.911381329198;5993.910091348546;6075.787347442818;6164.445199932027;6175.135481032569;6083.756649734138;6146.53900957439;6165.630062196283;6165.753369865155;6167.938320616916;5961.970190149022;5969.343372228965;5977.880442391215;5988.401159883977;5994.550408719277;4470.731756094645;5907.291125064848;5919.556033297434;5992.43071908168;6165.167702360124;5871.001929671881;5894.557908156819;5901.940980590139;5909.2908850938165;5941.346451890202 11:31:37 INFO - PROCESS | 1631 | |1;ext.html;464.25255338904356;470.6376090410384;497.3981482406288;500.78466259508394;510.7088959293202;31568.368632627364;40524.79737601311;42613.360799587994;42845.35731964023;44581.7770911145;38114.237715245676;43916.56083439165;44401.55598444014;44452.110957780824;44482.55517444824;8447.831043379128;9391.81216375672;9579.760505987371;9592;9605.615775368977;8513;11291.774164516704;11502.309861408343;11509.48207330672;11737.354445505494;11462.254953428042;11552.942235288812;11557.24877882935;11571.13216508761;11585.304881707083;8577.27093197079;11509.079273658088;11513.30920144794;11599.826002609925;11625.011873990721;8523.914760852374;11113.277636953653;11371.715707107305;11388.82916756241;11563.364014979174;41765.37351939723;42062.158756824996;42167.78916105431;42177.73466796001;42205.366919496235;3861.1698484825615;3936.645701886844;3951.4072889066583;3958.129211573449;3994.320965435883;28338.716612833814;28341.43317133646;28435;29347.41305173906;29503.70496295031;3064.601601791775;3357.362101200764;3359.96640033599;3360.0423879194313;3371.460566309379;499509;501391;501940;503741.4812925912;504597;59191.70404147952;59468;59547;59580.70209648924;59589;61606.383936160964;61845;61858;61882.69058654768;61944.69027654833;16058.678826423406;16256.75614865778;16279.674406511804;16282.43011494592;16323.102229377499;11377.317360958368;11633.76732465346;12649.241045537297;12705.618831435071;12766.106372554017;15082.793376529851;18942.473619845343;19530.31643892457;21933.890330548566;22503.66244506334;7454.509098180386;8799.252063574668;8844.159804818531;8866;9037.017784131222;845.8181490979468;859.7034023261965;862.4178679391385;869.3697069624471;880.0935036911991;30164.69835301663;30621.38757224843;31277.530837037462;31440.37119257602;31540.053798386085;1057.370864335719;1087.2932593813925;1087.8251488392516;1101.130107215291;1190.3334132885611;12857;16086.43697470583;16089.356425742839;16215.756763648555;16238.350465981464;622885;624703;627111;630984;632911;63550;64096.35903640997;64173.67913160404;64275.678621606596;64424.38939026468;1380.6617378742274;1404.1154072933987;1432.6919712261913;1445.0534899640961;1451.484722923368;29504.262393440335;30203.697963020968;30213;30470.23824404319;30844.691553084183;53549.196762047824;54007.72996134994;54024.64938376572;54037.459625404816;54092.72953635207;465442;465655.07586930436;467587;471753;473052;43972.90067748332;44594.77702611596;45042.437790339856;45231.54768452273;45327.320090198016;43464.78267608642;43832.56167438285;45728;49260;50172.498275016784;36555.81722091373;36616.26767464689;36796;37710.43434348432;37988;36666.083347916516;37249;37605.43591846179;37726.245475089796;38026.85919422422;29918;35899;35911.92264232077;36118;36954;31983.68016319807;33326.66673333236;33525;33528.832355838065;33587.49618755672;20177.39467815968;23921.641175382036;24283.392915176555;25046.499070018133;25675.871620641778 11:31:37 INFO - PROCESS | 1631 | |2;jquery.html;370.9777413355201;391.67099636305505;393.4020289160478;400.1976038043723;425.29401194017936;14049.94625403095;15222.923885380571;18223.99999999998;20657.483562910933;21198.470038249012;21465.356039318805;21720;22314.665280020814;22356.32931012068;22457.55084898301;5831.533477321804;5905.320888097859;6017.458428741413;6071.332153463138;6168.383161683818;4190.53904070552;5932.317783454915;6029.397060293979;6037.003894357425;6038.003729384646;4371.082072764707;6351.17434733484;6642.468602511787;6690.130283063195;6767.729290828361;6463.289038205794;6621.73513059477;6688.598684078922;6743.359380858835;6745.662716864137;5864.677442740647;5873.2952045754355;5873.7944171954205;5890.646561206341;5894.734736936848;24033.639495407584;25125.37186570332;25515.74484255152;25814.838332274903;26090.86954565215;2566.4353842154696;2595.974040259592;2620.423506828514;2629.6975847777367;2681.410089780245;10024.94987525065;10177.949110254476;10508.422036787973;12498.437570309357;15627.45303914369;1774.325756212644;1803.1074618064142;1812.4925020994142;1817.2458429751637;1823.5714607067328;97837;140107.59892401047;144326.27836860853;144865;146802.26598867044;9666.661666841626;11901.166918315635;11908.46411911466;11999.280043197436;12010.279383237033;13065.412056457482;15848.683026339639;15899.761503577225;15948.441804537018;15955.680886382208;8739.912600874037;8869.556522173865;8898.59956301968;8930.240929520933;9031.548422578844;7652.579108148994;8208.343332533503;8693.130686931256;8705.608247628872;8836.8674469883;3975.8210880510446;4650.883727906762;4776.567029891019;4782.115308667908;4871.975640121847;1961.2939341836927;2008.8192062714427;2010.4169790760516;2011.7787043425212;2018.5357367805486;410.30043775362935;416.55428691300017;426.1604638861438;831.5966756123275;890.950997695133;11910.46402911871;12134.193419839998;12311.56909508163;12401.875981240071;12456.501739930483;447.0723249257803;447.16826702333634;460.5233583241396;464.1876715747442;473.25462396724606;5933.169356290123;6006.939930600725;6110.175126357974;6277.937220627735;6278.497720182374;719934;727967.4447205232;734172;743155;756792;99205.51986200403;119356;129469.35265323802;144101.838472423;158450.20774896283;449.64028776978284;466.249338564917;467.7707923117648;467.81988934260556;469.66419010407725;10258.487075646039;10559.524821382902;11714.88285117138;11794.410279486163;12133.332666703416;50062.749686251336;59400.70299648474;59774.310156042215;59793.701031496304;59855.73574768645;82031.35937281101;82407.5879620598;85099.5745021271;85398.57300713456;85471.71792423243;7731.342835859015;8165;8228.50628962264;8420.789480262798;8484.321254299517;10988.945055274673;12794.424250908918;12873.485060597472;13324.133931294435;13386.397612107674;11027.669169924915;11084.057855082408;11210.663680089285;11279.770086217668;11449;10322.12261957742;10524.947375263075;10545.261831671709;11478.196526243082;11625.36060516646;11239.157063220455;11343.886561134614;11429;11480.712982175512;11777.293362398283;8247.628856701343;8295.751127466187;8387.245147936716;8482.982042154981;8492.363072769444;8430.36772242072;10945.890541094486;10959.835602466128;11214.831777523506;11420.543178273108 11:31:37 INFO - PROCESS | 1631 | |3;mootools.html;1365.9453621855125;1416.5537855575492;1422.0259122501093;1431.9140851548905;1433.2976841347736;8033.87949180762;8446.57767111645;8453.957730211348;8460.238578527931;8464.492130472176;7487.1764105948305;7723;7727.845443091135;8037.517748935068;8332.958335208315;2297.529006553661;2349.530093981202;2356.587597170488;2366.514864452783;2367.9408014799596;2305.400595845084;2339.6022676145094;2345.3901985483812;2347.6243800991847;2361.0083764818733;1874;2033.2781862438844;2107.1571371451387;2336.2056900653774;2363.5745565798147;2309.214866945238;2327.569399661068;2327.988360058189;2328.0222306631254;2328.499372634883;1871.5695390060225;2341.8829058547003;2347.7534858839745;2364.4916342986166;2369.893354799038;8293.585320733999;8363.58182090893;8370.414071015031;8381.413301068927;8386.664533418656;4372.89067773305;5093.719845408501;5256.448072952323;5276.894462110775;5279.736013199325;3360.22714775603;3546.840392182358;3570.589382221052;3582.4805403216646;3652.141746689526;1053.2364036073861;1182.1724792645098;1212.9575464858688;1252.0922331309728;1269.7587458382877;10338.328008679488;10583.417912014836;10585.153187744962;10610.681679549549;10750.193735469793;4475.216837053503;4530.637548996073;4584.587387135174;4588.242939914943;4589.954100458953;8771.561421928878;8791.032986371494;8797.944246690438;8802.163794439519;8808.20726134638;5185.585153187736;5187.584993200535;5197.402298735694;5199.324087868553;5208.817691380784;4782.497837727058;4796.37647105874;4854;4912.631552633567;4935.827246046371;3683.3922402803237;3788.2802267569073;3797.8290976906105;3837;3854.5567259764925;1157.4617802721775;1165.5920427850185;1176.9646910592696;1177.5231031432284;1188.5839956015498;856.4133568505594;858.9098144694842;868.8827008353918;882.188386684252;895.2479916869861;5108.795648174031;5305.204219367126;5367.436419176009;5393.541548968382;5399.055165346049;533.093740640912;545.62079354848;550.8898220355945;572.3275151696823;579.1920271221622;3287.6876696713775;3500.212452198286;3551.911202219965;3596.226811235597;3596.82015899204;9680.27397945143;10023;10035.448050357301;10040.146587539995;10069.848952265722;9926.553305101288;9970.950145249228;10035.799284014425;10037.447940363205;10044.547995340226;7279.199288078307;7537.924620753723;7649.694012239559;7728.999999999887;7741.419393545507;5229.111051121395;5230.503102205284;5268.394134674408;5360.946390536044;5435;7839.921600784147;8978.236849867573;9386.202172815387;9408.43549387039;9419.905800941902;8525.360597955303;8866.335024873031;9095.408798428081;9284.02517735628;9473.621055157717;6721.294264102199;6736.629485378351;7280.344768970818;7280.745173918887;7281.162666293232;7878.369730421668;7944.205579442009;8035.919640803517;8042.155573664915;8058.717944871902;7031.472639551952;7104.786856394317;7186.317299856505;7225.674844632109;7281.890771638536;7053.682584283617;7081.291870812877;7084.574925504487;7120.857582848417;7172.175199852084;6395.616263024233;6416.807495775134;6451.387118223761;6533.118029066015;6547.345265473415;3672.7429079964145;4805.159097158054;4847.636427267898;4852.902941941212;5028.296038554532;4851.369321988119;4939.53074457926;4968.975155124202;4981.078500477423;4983.127952608352 11:31:37 INFO - PROCESS | 1631 | |4;prototype.html;326.1845386533666;348.7262498938333;355.4313099041534;377.556371263765;380.97142714296416;4579.107074120544;5244.292020577221;5293.52358287754;5304;5308.70802105884;4207.1084247071485;4954.628402869781;5118.718470484131;5126.692398456095;5215.3832311983315;3314.850831712579;3464.8094354810473;4090.997705562134;4141.254574176647;4170.937435938464;4132.524759652633;4136.441580386654;4151.294279972412;4171.769328048233;4193.0984838259765;3995.8622137156626;4049.4533238012787;4107.691923105779;4112.650424713903;4154.792260386984;4077.3883917412327;4082.5713300103357;4085.5914408558906;4097.385392191195;4102.2821006324075;3023.183740390082;3040.802347847405;3609.981950090259;3611.6207798181076;3646.4348026055736;4318.747563206666;4489.236829738952;4710.222813235846;4890.902181956341;5207.578476008674;4676.36869022681;4695.953040469586;4738.2892566115015;4744.410622441486;4753.548412900804;4676.223035246619;5464.338892941739;5528.530074943635;5529.529989950859;5558.332500249909;3252.5283833844196;3380.932381352384;4036.979815100906;4038.8586399475876;4052.371882358239;4074.5314288856566;5616.02350754101;5716.971415142898;5762.049261871828;5839.8540036499;3738.2336620992633;3848.826802793881;4081.10215752534;4108.4453598763785;4114.670826333886;3954.8813535593977;4180.958190418118;4185.6232939035635;4193.706440549193;4207.990082380206;4147.6267135957305;4560.566746159109;4661.440627124767;4753.667243292936;4757.785899634525;4668.906621867543;5090.669106508065;5534.889302214014;5574.247476590689;5580.637258578179;1297.7339645372676;1339.8325209348832;1352.2224720785587;1359.2252416122715;1372.9382177802022;834.7036801935348;894.7250168509847;933.332667142996;934.8737920380797;947.2327414793901;4502.909941801146;4944.357233559686;5055;5058.519440653132;5063.620228482879;4762.285657151386;4785.401824771903;5443.768055097391;5566.970110529565;5641.746121424546;4239.51245606753;4440.666949978699;4710.929336059962;4919.327428674196;4968.602511799119;2442.009762043964;2449.860814721163;2720.1295585412477;2851.7148285171734;2933.911982640524;4579.7252164870215;4618.745968971672;5398.546199385444;5666.186820217573;5745.68398738065;4796.424429068465;5182.056728726728;5387.276071657032;5591.384947655754;5626.468089359722;4925.24186455586;5178.430372659004;5660.405657405995;5709.7430615623225;5713.800101978631;5130.384353877558;5347.850212204395;5358.97320513395;5374.811881584125;5378.892422151614;4587.954120458753;4905.9018819624125;4925.975370123127;4994.951060277383;5317.521423071942;5211.5049070338255;5471.644343117685;5575.4424557543925;5643.0249412705225;5662.688552129673;3365.495175723661;3443.1651992972766;3575.6066832648908;3899.7075219358094;3908.2965066288343;4518.096380723934;5178.689278643294;5311.486226425604;5313;5360.839174824761;4629.60648344881;4823.118983596471;5188.195829646411;5196.896062078662;5231.175165410636;4160.439835061852;4869.878253043702;5079.415867175175;5202.063628546898;5293.338332708411;4203.453551038346;4430.468343798636;5107.004134193797;5216.452272511332;5419.701916394636;4791.520847915181;4931.778069986931;5515.22786809855;5544.279243698294;5672.2342483765815;4473.888152796076;5436.700981446058;5451.936872310021;5460.34475862899;5467.234587157881 11:31:37 INFO - PROCESS | 1631 | |5;yui.html;713.2403989750918;730.1967835381079;767.9078510578728;813.101522817287;821.0639870547575;14642.414303427864;15480.148591827445;15502.68994620107;15519.456819011337;15529.301181446834;14288.428462861499;14293.928530357334;14304.141751494917;14354.497592584261;14474.782878256834;684.2473279392678;701.8876979683251;850.8893843800297;860.7805009722528;875.4615911214621;680.4590350671228;871.424859592669;877.6313948141795;878.1043335797483;880.1110878013221;944.759086432962;945.877035985321;945.957431915562;947.0624082158648;947.8530827721714;730.477708438469;751.9924800751977;942.4533770413144;944.8582712593166;945.4091193004373;672.5863593889771;686.6017709728345;697.1808125452624;697.9092717946635;698.7170196070599;14958.681404382229;15198.848011519854;15203.695926081416;15204.46784362542;15239.923800381039;13652.522161724391;13694.52069177584;13695.657608559766;13719;14147.717045659132;10942;11514.712132196762;12275.447604857714;12527.997760179163;12851.35743212845;4301;4351.5648435156545;4399.802008909607;4447.822087116511;4467.798949047268;100340.49829750805;100965;102668;103427.44858827123;103871;8980.595873185723;10506.789864202674;10655.520501577448;10795.838062428913;10938.56245750161;20581.794182058286;20956.161753529992;20956.26653067166;21042.947852607307;21285.78714212869;7279.781606551812;7563.357114645317;7685.269899359552;7784.571848548384;7830.765077047698;4143.81352839123;4158.209940111369;4218.367244913287;4230.809613567397;4299.94651310431;3407.454807230831;3486.2678837443914;3491.4064609016527;3500.64993500653;3504.491848681927;633.5691729623808;640.6316368088368;642.787879999599;653.9313372095957;657.4871600151889;518.3934796288352;519.5220397234477;524.9895002099937;525.3092183778319;539.5629540072554;9282.72151835446;9746;9843.188646997587;9908.554115064839;9983.351082179635;543.1581049373534;543.8504411286928;569.6012791046285;579.507418694115;607.875385545962;4094.4267802507675;4343.522212556616;4935.0779065122;4950.43070046942;4980.850574482772;92939.53530232306;94670.52664736632;95824.56263156058;96703.51648241855;99452;72957;74838.25161748422;82119;83664.58167709122;84144;73133;74181;74471.88292175731;74584;75903;9459.243260539279;9535.570899309409;9542.522873856418;9572.664956726481;9576.090271424204;46741.2988805175;47906.520934790206;48057.279140812214;49032;49115.50884491109;55335.44664553464;55744.72127639336;59657.701711491165;63751.6812415935;65225.02162467472;12829.550965716155;13035;13215.273159975908;13380;13834.239116848268;14125.293735313398;14363;14998.175100369584;15040.247987600795;15504.689906202038;11972.281663100242;12523.185992910432;12895.742085158432;13239.536616218385;13609.93195034058;12962.740745184854;13699.178049317074;13860.306984650928;13886.791698124334;14179.645508861948;12192.329421881881;13373.264470454218;13376.665583360495;13505;13625.454981801013;7880.645370958206;10773.946130269298;10898.782024359627;11218.382988935688;11558.537658493902;8347.58262086881;8897.866532001895;9572.593247163253;10853.45732713377;10870.782584348111 11:31:37 INFO - PROCESS | 1631 | __end_tp_report 11:31:37 INFO - PROCESS | 1631 | __start_cc_report 11:31:37 INFO - PROCESS | 1631 | _x_x_mozilla_cycle_collect,1933 11:31:37 INFO - PROCESS | 1631 | __end_cc_report 11:31:37 INFO - PROCESS | 1631 | __startTimestamp1487791897972__endTimestamp 11:31:37 INFO - PROCESS | 1631 | 11:31:37 INFO - PROCESS | 1631 | ------- Summary: start ------- 11:31:37 INFO - PROCESS | 1631 | Number of tests: 6 11:31:37 INFO - PROCESS | 1631 | 11:31:37 INFO - PROCESS | 1631 | [#0] dojo.html Cycles:165 Average:5719.66 Median:5919.56 stddev:671.07 (11.3%) stddev-sans-first:646.80 11:31:37 INFO - PROCESS | 1631 | Values: 3346.9 3363.4 3366.8 3378.3 3421.7 5590.4 5619.0 5634.3 5643.7 5648.0 5562.5 5570.9 5621.2 5624.1 5627.9 5148.5 5151.0 5165.1 5172.6 5217.1 5136.6 5161.3 5225.3 5262.5 5278.9 3937.0 4783.6 5165.1 5180.0 5279.5 5187.8 5254.1 5269.6 5274.3 5275.8 4976.6 5172.9 5177.9 5206.4 5222.2 5520.2 5539.2 5548.9 5576.2 5632.5 6138.8 6149.2 6175.6 6177.8 6177.9 6185.0 6240.5 6247.6 6268.7 6269.5 5595.9 5653.9 5667.2 5719.3 5766.3 6272.7 6313.4 6328.7 6341.7 6357.3 6169.8 6181.9 6193.1 6194.2 6202.6 6235.8 6273.9 6278.6 6295.8 6306.7 6014.6 6048.9 6060.4 6116.8 6213.1 6119.0 6166.9 6180.2 6250.5 6261.0 4951.8 4977.9 4990.4 4999.8 5035.9 3930.0 4433.4 4459.1 4464.9 4471.2 5602.0 5647.0 5653.7 5726.1 5767.2 6250.4 6283.9 6295.0 6300.6 6302.9 5743.6 5782.4 5798.7 5805.6 5830.2 5295.5 5377.9 5384.9 5411.8 5466.4 6319.7 6380.3 6424.0 6424.8 6430.0 6270.2 6298.5 6303.6 6311.7 6313.2 6190.1 6308.8 6340.3 6374.4 6391.2 6106.6 6227.4 6227.7 6234.3 6259.7 6122.1 6247.6 6302.1 6326.6 6328.7 5907.9 5993.9 6075.8 6164.4 6175.1 6083.8 6146.5 6165.6 6165.8 6167.9 5962.0 5969.3 5977.9 5988.4 5994.6 4470.7 5907.3 5919.6 5992.4 6165.2 5871.0 5894.6 5901.9 5909.3 5941.3 11:31:37 INFO - PROCESS | 1631 | 11:31:37 INFO - PROCESS | 1631 | [#1] ext.html Cycles:180 Average:68009.28 Median:37857.12 stddev:143132.88 (378.1%) stddev-sans-first:143444.56 11:31:37 INFO - PROCESS | 1631 | Values: 464.3 470.6 497.4 500.8 510.7 31568.4 40524.8 42613.4 42845.4 44581.8 38114.2 43916.6 44401.6 44452.1 44482.6 8447.8 9391.8 9579.8 9592.0 9605.6 8513.0 11291.8 11502.3 11509.5 11737.4 11462.3 11552.9 11557.2 11571.1 11585.3 8577.3 11509.1 11513.3 11599.8 11625.0 8523.9 11113.3 11371.7 11388.8 11563.4 41765.4 42062.2 42167.8 42177.7 42205.4 3861.2 3936.6 3951.4 3958.1 3994.3 28338.7 28341.4 28435.0 29347.4 29503.7 3064.6 3357.4 3360.0 3360.0 3371.5 499509.0 501391.0 501940.0 503741.5 504597.0 59191.7 59468.0 59547.0 59580.7 59589.0 61606.4 61845.0 61858.0 61882.7 61944.7 16058.7 16256.8 16279.7 16282.4 16323.1 11377.3 11633.8 12649.2 12705.6 12766.1 15082.8 18942.5 19530.3 21933.9 22503.7 7454.5 8799.3 8844.2 8866.0 9037.0 845.8 859.7 862.4 869.4 880.1 30164.7 30621.4 31277.5 31440.4 31540.1 1057.4 1087.3 1087.8 1101.1 1190.3 12857.0 16086.4 16089.4 16215.8 16238.4 622885.0 624703.0 627111.0 630984.0 632911.0 63550.0 64096.4 64173.7 64275.7 64424.4 1380.7 1404.1 1432.7 1445.1 1451.5 29504.3 30203.7 30213.0 30470.2 30844.7 53549.2 54007.7 54024.6 54037.5 54092.7 465442.0 465655.1 467587.0 471753.0 473052.0 43972.9 44594.8 45042.4 45231.5 45327.3 43464.8 43832.6 45728.0 49260.0 50172.5 36555.8 36616.3 36796.0 37710.4 37988.0 36666.1 37249.0 37605.4 37726.2 38026.9 29918.0 35899.0 35911.9 36118.0 36954.0 31983.7 33326.7 33525.0 33528.8 33587.5 20177.4 23921.6 24283.4 25046.5 25675.9 11:31:37 INFO - PROCESS | 1631 | 11:31:37 INFO - PROCESS | 1631 | [#2] jquery.html Cycles:180 Average:39186.29 Median:405.25 stddev:122463.20 (30219.2%) stddev-sans-first:122772.05 11:31:37 INFO - PROCESS | 1631 | Values: 371.0 391.7 393.4 400.2 425.3 14049.9 15222.9 18224.0 20657.5 21198.5 21465.4 21720.0 22314.7 22356.3 22457.6 5831.5 5905.3 6017.5 6071.3 6168.4 4190.5 5932.3 6029.4 6037.0 6038.0 4371.1 6351.2 6642.5 6690.1 6767.7 6463.3 6621.7 6688.6 6743.4 6745.7 5864.7 5873.3 5873.8 5890.6 5894.7 24033.6 25125.4 25515.7 25814.8 26090.9 2566.4 2596.0 2620.4 2629.7 2681.4 10024.9 10177.9 10508.4 12498.4 15627.5 1774.3 1803.1 1812.5 1817.2 1823.6 97837.0 140107.6 144326.3 144865.0 146802.3 9666.7 11901.2 11908.5 11999.3 12010.3 13065.4 15848.7 15899.8 15948.4 15955.7 8739.9 8869.6 8898.6 8930.2 9031.5 7652.6 8208.3 8693.1 8705.6 8836.9 3975.8 4650.9 4776.6 4782.1 4872.0 1961.3 2008.8 2010.4 2011.8 2018.5 410.3 416.6 426.2 831.6 891.0 11910.5 12134.2 12311.6 12401.9 12456.5 447.1 447.2 460.5 464.2 473.3 5933.2 6006.9 6110.2 6277.9 6278.5 719934.0 727967.4 734172.0 743155.0 756792.0 99205.5 119356.0 129469.4 144101.8 158450.2 449.6 466.2 467.8 467.8 469.7 10258.5 10559.5 11714.9 11794.4 12133.3 50062.7 59400.7 59774.3 59793.7 59855.7 82031.4 82407.6 85099.6 85398.6 85471.7 7731.3 8165.0 8228.5 8420.8 8484.3 10988.9 12794.4 12873.5 13324.1 13386.4 11027.7 11084.1 11210.7 11279.8 11449.0 10322.1 10524.9 10545.3 11478.2 11625.4 11239.2 11343.9 11429.0 11480.7 11777.3 8247.6 8295.8 8387.2 8483.0 8492.4 8430.4 10945.9 10959.8 11214.8 11420.5 11:31:37 INFO - PROCESS | 1631 | 11:31:37 INFO - PROCESS | 1631 | [#3] mootools.html Cycles:180 Average:5352.71 Median:5186.59 stddev:2935.66 (56.6%) stddev-sans-first:2928.60 11:31:37 INFO - PROCESS | 1631 | Values: 1365.9 1416.6 1422.0 1431.9 1433.3 8033.9 8446.6 8454.0 8460.2 8464.5 7487.2 7723.0 7727.8 8037.5 8333.0 2297.5 2349.5 2356.6 2366.5 2367.9 2305.4 2339.6 2345.4 2347.6 2361.0 1874.0 2033.3 2107.2 2336.2 2363.6 2309.2 2327.6 2328.0 2328.0 2328.5 1871.6 2341.9 2347.8 2364.5 2369.9 8293.6 8363.6 8370.4 8381.4 8386.7 4372.9 5093.7 5256.4 5276.9 5279.7 3360.2 3546.8 3570.6 3582.5 3652.1 1053.2 1182.2 1213.0 1252.1 1269.8 10338.3 10583.4 10585.2 10610.7 10750.2 4475.2 4530.6 4584.6 4588.2 4590.0 8771.6 8791.0 8797.9 8802.2 8808.2 5185.6 5187.6 5197.4 5199.3 5208.8 4782.5 4796.4 4854.0 4912.6 4935.8 3683.4 3788.3 3797.8 3837.0 3854.6 1157.5 1165.6 1177.0 1177.5 1188.6 856.4 858.9 868.9 882.2 895.2 5108.8 5305.2 5367.4 5393.5 5399.1 533.1 545.6 550.9 572.3 579.2 3287.7 3500.2 3551.9 3596.2 3596.8 9680.3 10023.0 10035.4 10040.1 10069.8 9926.6 9971.0 10035.8 10037.4 10044.5 7279.2 7537.9 7649.7 7729.0 7741.4 5229.1 5230.5 5268.4 5360.9 5435.0 7839.9 8978.2 9386.2 9408.4 9419.9 8525.4 8866.3 9095.4 9284.0 9473.6 6721.3 6736.6 7280.3 7280.7 7281.2 7878.4 7944.2 8035.9 8042.2 8058.7 7031.5 7104.8 7186.3 7225.7 7281.9 7053.7 7081.3 7084.6 7120.9 7172.2 6395.6 6416.8 6451.4 6533.1 6547.3 3672.7 4805.2 4847.6 4852.9 5028.3 4851.4 4939.5 4969.0 4981.1 4983.1 11:31:37 INFO - PROCESS | 1631 | 11:31:37 INFO - PROCESS | 1631 | [#4] prototype.html Cycles:180 Average:4376.17 Median:4760.04 stddev:1289.54 (27.1%) stddev-sans-first:1256.82 11:31:37 INFO - PROCESS | 1631 | Values: 326.2 348.7 355.4 377.6 381.0 4579.1 5244.3 5293.5 5304.0 5308.7 4207.1 4954.6 5118.7 5126.7 5215.4 3314.9 3464.8 4091.0 4141.3 4170.9 4132.5 4136.4 4151.3 4171.8 4193.1 3995.9 4049.5 4107.7 4112.7 4154.8 4077.4 4082.6 4085.6 4097.4 4102.3 3023.2 3040.8 3610.0 3611.6 3646.4 4318.7 4489.2 4710.2 4890.9 5207.6 4676.4 4696.0 4738.3 4744.4 4753.5 4676.2 5464.3 5528.5 5529.5 5558.3 3252.5 3380.9 4037.0 4038.9 4052.4 4074.5 5616.0 5717.0 5762.0 5839.9 3738.2 3848.8 4081.1 4108.4 4114.7 3954.9 4181.0 4185.6 4193.7 4208.0 4147.6 4560.6 4661.4 4753.7 4757.8 4668.9 5090.7 5534.9 5574.2 5580.6 1297.7 1339.8 1352.2 1359.2 1372.9 834.7 894.7 933.3 934.9 947.2 4502.9 4944.4 5055.0 5058.5 5063.6 4762.3 4785.4 5443.8 5567.0 5641.7 4239.5 4440.7 4710.9 4919.3 4968.6 2442.0 2449.9 2720.1 2851.7 2933.9 4579.7 4618.7 5398.5 5666.2 5745.7 4796.4 5182.1 5387.3 5591.4 5626.5 4925.2 5178.4 5660.4 5709.7 5713.8 5130.4 5347.9 5359.0 5374.8 5378.9 4588.0 4905.9 4926.0 4995.0 5317.5 5211.5 5471.6 5575.4 5643.0 5662.7 3365.5 3443.2 3575.6 3899.7 3908.3 4518.1 5178.7 5311.5 5313.0 5360.8 4629.6 4823.1 5188.2 5196.9 5231.2 4160.4 4869.9 5079.4 5202.1 5293.3 4203.5 4430.5 5107.0 5216.5 5419.7 4791.5 4931.8 5515.2 5544.3 5672.2 4473.9 5436.7 5451.9 5460.3 5467.2 11:31:37 INFO - PROCESS | 1631 | 11:31:37 INFO - PROCESS | 1631 | [#5] yui.html Cycles:180 Average:19460.86 Median:49073.75 stddev:27390.01 (55.8%) stddev-sans-first:27430.67 11:31:37 INFO - PROCESS | 1631 | Values: 713.2 730.2 767.9 813.1 821.1 14642.4 15480.1 15502.7 15519.5 15529.3 14288.4 14293.9 14304.1 14354.5 14474.8 684.2 701.9 850.9 860.8 875.5 680.5 871.4 877.6 878.1 880.1 944.8 945.9 946.0 947.1 947.9 730.5 752.0 942.5 944.9 945.4 672.6 686.6 697.2 697.9 698.7 14958.7 15198.8 15203.7 15204.5 15239.9 13652.5 13694.5 13695.7 13719.0 14147.7 10942.0 11514.7 12275.4 12528.0 12851.4 4301.0 4351.6 4399.8 4447.8 4467.8 100340.5 100965.0 102668.0 103427.4 103871.0 8980.6 10506.8 10655.5 10795.8 10938.6 20581.8 20956.2 20956.3 21042.9 21285.8 7279.8 7563.4 7685.3 7784.6 7830.8 4143.8 4158.2 4218.4 4230.8 4299.9 3407.5 3486.3 3491.4 3500.6 3504.5 633.6 640.6 642.8 653.9 657.5 518.4 519.5 525.0 525.3 539.6 9282.7 9746.0 9843.2 9908.6 9983.4 543.2 543.9 569.6 579.5 607.9 4094.4 4343.5 4935.1 4950.4 4980.9 92939.5 94670.5 95824.6 96703.5 99452.0 72957.0 74838.3 82119.0 83664.6 84144.0 73133.0 74181.0 74471.9 74584.0 75903.0 9459.2 9535.6 9542.5 9572.7 9576.1 46741.3 47906.5 48057.3 49032.0 49115.5 55335.4 55744.7 59657.7 63751.7 65225.0 12829.6 13035.0 13215.3 13380.0 13834.2 14125.3 14363.0 14998.2 15040.2 15504.7 11972.3 12523.2 12895.7 13239.5 13609.9 12962.7 13699.2 13860.3 13886.8 14179.6 12192.3 13373.3 13376.7 13505.0 13625.5 7880.6 10773.9 10898.8 11218.4 11558.5 8347.6 8897.9 9572.6 10853.5 10870.8 11:31:37 INFO - PROCESS | 1631 | -------- Summary: end -------- 11:31:37 INFO - PROCESS | 1631 | 11:31:38 INFO - TEST-INFO | 1631: exit 0 11:31:38 INFO - TEST-OK | dromaeo_css | took 1118556ms 11:31:38 INFO - TEST-START | kraken 11:31:38 INFO - operating with platform_type : mac_ 11:31:38 INFO - Initialising browser for kraken test... 11:31:38 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpa3o60A/profile http://localhost:49236/getInfo.html) 11:31:40 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 11:31:40 INFO - PROCESS | 1642 | colorDepth:24 11:31:40 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 11:31:40 INFO - PROCESS | 1642 | __metrics 11:31:40 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:31:40 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:31:41 INFO - TEST-INFO | 1642: exit 0 11:31:41 INFO - Browser initialized. 11:31:41 INFO - Running cycle 1/1 for kraken test... 11:31:41 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpa3o60A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:53 INFO - PROCESS | 1643 | RSS: Main: 213200896 11:31:53 INFO - PROCESS | 1643 | 11:31:56 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:57 INFO - PROCESS | 1643 | RSS: Main: 266407936 11:31:57 INFO - PROCESS | 1643 | 11:31:59 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 11:32:00 INFO - PROCESS | 1643 | RSS: Main: 275369984 11:32:00 INFO - PROCESS | 1643 | 11:32:03 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 11:32:04 INFO - PROCESS | 1643 | RSS: Main: 372756480 11:32:04 INFO - PROCESS | 1643 | 11:32:06 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 11:32:07 INFO - PROCESS | 1643 | RSS: Main: 276434944 11:32:07 INFO - PROCESS | 1643 | 11:32:09 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:09 INFO - PROCESS | 1643 | RSS: Main: 277614592 11:32:09 INFO - PROCESS | 1643 | 11:32:12 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:13 INFO - PROCESS | 1643 | RSS: Main: 319766528 11:32:13 INFO - PROCESS | 1643 | 11:32:16 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:16 INFO - PROCESS | 1643 | RSS: Main: 319623168 11:32:16 INFO - PROCESS | 1643 | 11:32:19 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 11:32:20 INFO - PROCESS | 1643 | RSS: Main: 317333504 11:32:20 INFO - PROCESS | 1643 | 11:32:21 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:22 INFO - PROCESS | 1643 | RSS: Main: 295526400 11:32:22 INFO - PROCESS | 1643 | 11:32:24 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:25 INFO - PROCESS | 1643 | RSS: Main: 299819008 11:32:25 INFO - PROCESS | 1643 | 11:32:27 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:27 INFO - PROCESS | 1643 | RSS: Main: 302780416 11:32:27 INFO - PROCESS | 1643 | 11:32:30 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:31 INFO - PROCESS | 1643 | RSS: Main: 310542336 11:32:31 INFO - PROCESS | 1643 | 11:32:34 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:35 INFO - PROCESS | 1643 | RSS: Main: 309407744 11:32:35 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 11:32:37 INFO - PROCESS | 1643 | RSS: Main: 353939456 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | __start_tp_report 11:32:37 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 11:32:37 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 11:32:37 INFO - PROCESS | 1643 | |i|pagename|runs| 11:32:37 INFO - PROCESS | 1643 | |0;ai-astar;115;116;114;114;113;114;114;114;113;115 11:32:37 INFO - PROCESS | 1643 | |1;audio-beat-detection;167;139;123;160;93;110;127;137;153;108 11:32:37 INFO - PROCESS | 1643 | |2;audio-dft;185;185;183;183;185;181;184;185;183;182 11:32:37 INFO - PROCESS | 1643 | |3;audio-fft;79;61;58;82;57;61;78;82;97;83 11:32:37 INFO - PROCESS | 1643 | |4;audio-oscillator;90;70;85;73;95;100;114;67;69;82 11:32:37 INFO - PROCESS | 1643 | |5;imaging-gaussian-blur;88;84;88;85;88;131;87;84;87;84 11:32:37 INFO - PROCESS | 1643 | |6;imaging-darkroom;153;169;96;97;99;98;96;96;98;95 11:32:37 INFO - PROCESS | 1643 | |7;imaging-desaturate;88;84;95;129;86;89;87;85;85;87 11:32:37 INFO - PROCESS | 1643 | |8;json-parse-financial;53;53;54;54;56;57;57;57;57;56 11:32:37 INFO - PROCESS | 1643 | |9;json-stringify-tinderbox;66;73;75;72;72;68;69;69;68;94 11:32:37 INFO - PROCESS | 1643 | |10;stanford-crypto-aes;82;84;87;84;84;72;94;73;89;102 11:32:37 INFO - PROCESS | 1643 | |11;stanford-crypto-ccm;159;170;152;145;138;139;140;140;256;147 11:32:37 INFO - PROCESS | 1643 | |12;stanford-crypto-pbkdf2;165;167;167;169;171;167;171;228;197;167 11:32:37 INFO - PROCESS | 1643 | |13;stanford-crypto-sha256-iterative;66;67;66;67;67;67;65;65;64;65 11:32:37 INFO - PROCESS | 1643 | __end_tp_report 11:32:37 INFO - PROCESS | 1643 | __start_cc_report 11:32:37 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,2072 11:32:37 INFO - PROCESS | 1643 | __end_cc_report 11:32:37 INFO - PROCESS | 1643 | __startTimestamp1487791957264__endTimestamp 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | ------- Summary: start ------- 11:32:37 INFO - PROCESS | 1643 | Number of tests: 14 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 11:32:37 INFO - PROCESS | 1643 | Values: 115.0 116.0 114.0 114.0 113.0 114.0 114.0 114.0 113.0 115.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:146.00 stddev:24.06 (16.5%) stddev-sans-first:21.87 11:32:37 INFO - PROCESS | 1643 | Values: 167.0 139.0 123.0 160.0 93.0 110.0 127.0 137.0 153.0 108.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.50 stddev:1.43 (0.8%) stddev-sans-first:1.42 11:32:37 INFO - PROCESS | 1643 | Values: 185.0 185.0 183.0 183.0 185.0 181.0 184.0 185.0 183.0 182.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#3] audio-fft Cycles:10 Average:73.80 Median:80.50 stddev:13.59 (16.9%) stddev-sans-first:14.28 11:32:37 INFO - PROCESS | 1643 | Values: 79.0 61.0 58.0 82.0 57.0 61.0 78.0 82.0 97.0 83.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#4] audio-oscillator Cycles:10 Average:84.50 Median:77.50 stddev:15.44 (19.9%) stddev-sans-first:16.25 11:32:37 INFO - PROCESS | 1643 | Values: 90.0 70.0 85.0 73.0 95.0 100.0 114.0 67.0 69.0 82.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:87.00 stddev:14.30 (16.4%) stddev-sans-first:15.14 11:32:37 INFO - PROCESS | 1643 | Values: 88.0 84.0 88.0 85.0 88.0 131.0 87.0 84.0 87.0 84.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#6] imaging-darkroom Cycles:10 Average:109.70 Median:96.50 stddev:27.33 (28.3%) stddev-sans-first:24.08 11:32:37 INFO - PROCESS | 1643 | Values: 153.0 169.0 96.0 97.0 99.0 98.0 96.0 96.0 98.0 95.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#7] imaging-desaturate Cycles:10 Average:91.50 Median:87.00 stddev:13.53 (15.6%) stddev-sans-first:14.30 11:32:37 INFO - PROCESS | 1643 | Values: 88.0 84.0 95.0 129.0 86.0 89.0 87.0 85.0 85.0 87.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.50 stddev:1.71 (3.0%) stddev-sans-first:1.58 11:32:37 INFO - PROCESS | 1643 | Values: 53.0 53.0 54.0 54.0 56.0 57.0 57.0 57.0 57.0 56.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:72.00 stddev:8.00 (11.1%) stddev-sans-first:8.12 11:32:37 INFO - PROCESS | 1643 | Values: 66.0 73.0 75.0 72.0 72.0 68.0 69.0 69.0 68.0 94.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:8.91 (10.6%) stddev-sans-first:9.38 11:32:37 INFO - PROCESS | 1643 | Values: 82.0 84.0 87.0 84.0 84.0 72.0 94.0 73.0 89.0 102.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#11] stanford-crypto-ccm Cycles:10 Average:158.60 Median:149.50 stddev:35.72 (23.9%) stddev-sans-first:37.88 11:32:37 INFO - PROCESS | 1643 | Values: 159.0 170.0 152.0 145.0 138.0 139.0 140.0 140.0 256.0 147.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:170.00 stddev:20.22 (11.9%) stddev-sans-first:20.99 11:32:37 INFO - PROCESS | 1643 | Values: 165.0 167.0 167.0 169.0 171.0 167.0 171.0 228.0 197.0 167.0 11:32:37 INFO - PROCESS | 1643 | 11:32:37 INFO - PROCESS | 1643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:1.10 (1.7%) stddev-sans-first:1.17 11:32:37 INFO - PROCESS | 1643 | Values: 66.0 67.0 66.0 67.0 67.0 67.0 65.0 65.0 64.0 65.0 11:32:37 INFO - PROCESS | 1643 | -------- Summary: end -------- 11:32:37 INFO - PROCESS | 1643 | 11:32:38 INFO - TEST-INFO | 1643: exit 0 11:32:38 INFO - TEST-OK | kraken | took 59621ms 11:32:38 INFO - SUITE-END | took 1178s 11:32:38 INFO - Completed test suite (00:19:38) 11:32:38 INFO - javascript benchmark 11:32:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3346.949795753064, 3363.4114030044734, 3366.8148251846155, 3378.341223461426, 3421.70915472185, 5590.385057643661, 5619.0, 5634.295713035871, 5643.717814109299, 5648.0, 5562.499375056244, 5570.86072848179, 5621.241132447119, 5624.072028115366, 5627.859303517414, 5148.459411761767, 5151.021305951876, 5165.096108181072, 5172.612054095939, 5217.087009773293, 5136.614753893473, 5161.329027226455, 5225.294585230983, 5262.473752624726, 5278.894422111555, 3937.0, 4783.569478746912, 5165.121929272014, 5180.0, 5279.498447647467, 5187.818426355078, 5254.054270231338, 5269.604779641504, 5274.2879711238875, 5275.841724748264, 4976.62675299354, 5172.922406163911, 5177.922331165036, 5206.427292997767, 5222.190560463135, 5520.171974203861, 5539.224508568804, 5548.86127846803, 5576.163575463673, 5632.549396048306, 6138.815835524942, 6149.200603921507, 6175.629462232236, 6177.7837775677635, 6177.876442471171, 6185.041318595625, 6240.469560087398, 6247.562670613059, 6268.65522396268, 6269.498440124779, 5595.888082238333, 5653.8586535336535, 5667.234923285386, 5719.313682358102, 5766.336871259775, 6272.686365681698, 6313.40022697843, 6328.6519241442165, 6341.651209183539, 6357.268914074848, 6169.81490555284, 6181.938180618136, 6193.102000209944, 6194.225721784777, 6202.627842329474, 6235.812925612239, 6273.937260627426, 6278.591891527036, 6295.779647712308, 6306.716197771111, 6014.6391216527145, 6048.879022419527, 6060.363661815446, 6116.771101367247, 6213.068039794067, 6119.015143218386, 6166.938330616636, 6180.227471566054, 6250.499960003189, 6260.968695156586, 4951.8266860659705, 4977.875553111201, 4990.4011518618, 4999.775010124553, 5035.874103147377, 3929.980350098231, 4433.401490798701, 4459.063596644741, 4464.933026004613, 4471.195184866755, 5602.0, 5647.0, 5653.689047102449, 5726.141078838207, 5767.163761254678, 6250.406211409909, 6283.874322513616, 6294.968525157345, 6300.558960872695, 6302.873942521215, 5743.62666426681, 5782.421757824184, 5798.739056742456, 5805.593608447368, 5830.183774271605, 5295.523402893758, 5377.946220537823, 5384.865378365494, 5411.810586629449, 5466.398696143421, 6319.715612797343, 6380.298167201697, 6424.0, 6424.775132870327, 6429.967850160906, 6270.184875966095, 6298.496120310272, 6303.590266632654, 6311.747530098744, 6313.210848643919, 6190.102435146969, 6308.779192728232, 6340.334264902303, 6374.362563743589, 6391.169148010729, 6106.612350340234, 6227.408396202353, 6227.688615569294, 6234.2830574484515, 6259.65571893532, 6122.142899994094, 6247.5939063960695, 6302.054691796084, 6326.557141000086, 6328.683565821782, 5907.911381329198, 5993.910091348546, 6075.787347442818, 6164.445199932027, 6175.135481032569, 6083.756649734138, 6146.53900957439, 6165.630062196283, 6165.753369865155, 6167.938320616916, 5961.970190149022, 5969.343372228965, 5977.880442391215, 5988.401159883977, 5994.550408719277, 4470.731756094645, 5907.291125064848, 5919.556033297434, 5992.43071908168, 6165.167702360124, 5871.001929671881, 5894.557908156819, 5901.940980590139, 5909.2908850938165, 5941.346451890202], "value": 5675.971060272244, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.25255338904356, 470.6376090410384, 497.3981482406288, 500.78466259508394, 510.7088959293202, 31568.368632627364, 40524.79737601311, 42613.360799587994, 42845.35731964023, 44581.7770911145, 38114.237715245676, 43916.56083439165, 44401.55598444014, 44452.110957780824, 44482.55517444824, 8447.831043379128, 9391.81216375672, 9579.760505987371, 9592.0, 9605.615775368977, 8513.0, 11291.774164516704, 11502.309861408343, 11509.48207330672, 11737.354445505494, 11462.254953428042, 11552.942235288812, 11557.24877882935, 11571.13216508761, 11585.304881707083, 8577.27093197079, 11509.079273658088, 11513.30920144794, 11599.826002609925, 11625.011873990721, 8523.914760852374, 11113.277636953653, 11371.715707107305, 11388.82916756241, 11563.364014979174, 41765.37351939723, 42062.158756824996, 42167.78916105431, 42177.73466796001, 42205.366919496235, 3861.1698484825615, 3936.645701886844, 3951.4072889066583, 3958.129211573449, 3994.320965435883, 28338.716612833814, 28341.43317133646, 28435.0, 29347.41305173906, 29503.70496295031, 3064.601601791775, 3357.362101200764, 3359.96640033599, 3360.0423879194313, 3371.460566309379, 499509.0, 501391.0, 501940.0, 503741.4812925912, 504597.0, 59191.70404147952, 59468.0, 59547.0, 59580.70209648924, 59589.0, 61606.383936160964, 61845.0, 61858.0, 61882.69058654768, 61944.69027654833, 16058.678826423406, 16256.75614865778, 16279.674406511804, 16282.43011494592, 16323.102229377499, 11377.317360958368, 11633.76732465346, 12649.241045537297, 12705.618831435071, 12766.106372554017, 15082.793376529851, 18942.473619845343, 19530.31643892457, 21933.890330548566, 22503.66244506334, 7454.509098180386, 8799.252063574668, 8844.159804818531, 8866.0, 9037.017784131222, 845.8181490979468, 859.7034023261965, 862.4178679391385, 869.3697069624471, 880.0935036911991, 30164.69835301663, 30621.38757224843, 31277.530837037462, 31440.37119257602, 31540.053798386085, 1057.370864335719, 1087.2932593813925, 1087.8251488392516, 1101.130107215291, 1190.3334132885611, 12857.0, 16086.43697470583, 16089.356425742839, 16215.756763648555, 16238.350465981464, 622885.0, 624703.0, 627111.0, 630984.0, 632911.0, 63550.0, 64096.35903640997, 64173.67913160404, 64275.678621606596, 64424.38939026468, 1380.6617378742274, 1404.1154072933987, 1432.6919712261913, 1445.0534899640961, 1451.484722923368, 29504.262393440335, 30203.697963020968, 30213.0, 30470.23824404319, 30844.691553084183, 53549.196762047824, 54007.72996134994, 54024.64938376572, 54037.459625404816, 54092.72953635207, 465442.0, 465655.07586930436, 467587.0, 471753.0, 473052.0, 43972.90067748332, 44594.77702611596, 45042.437790339856, 45231.54768452273, 45327.320090198016, 43464.78267608642, 43832.56167438285, 45728.0, 49260.0, 50172.498275016784, 36555.81722091373, 36616.26767464689, 36796.0, 37710.43434348432, 37988.0, 36666.083347916516, 37249.0, 37605.43591846179, 37726.245475089796, 38026.85919422422, 29918.0, 35899.0, 35911.92264232077, 36118.0, 36954.0, 31983.68016319807, 33326.66673333236, 33525.0, 33528.832355838065, 33587.49618755672, 20177.39467815968, 23921.641175382036, 24283.392915176555, 25046.499070018133, 25675.871620641778], "value": 20561.81227700091, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.9777413355201, 391.67099636305505, 393.4020289160478, 400.1976038043723, 425.29401194017936, 14049.94625403095, 15222.923885380571, 18223.99999999998, 20657.483562910933, 21198.470038249012, 21465.356039318805, 21720.0, 22314.665280020814, 22356.32931012068, 22457.55084898301, 5831.533477321804, 5905.320888097859, 6017.458428741413, 6071.332153463138, 6168.383161683818, 4190.53904070552, 5932.317783454915, 6029.397060293979, 6037.003894357425, 6038.003729384646, 4371.082072764707, 6351.17434733484, 6642.468602511787, 6690.130283063195, 6767.729290828361, 6463.289038205794, 6621.73513059477, 6688.598684078922, 6743.359380858835, 6745.662716864137, 5864.677442740647, 5873.2952045754355, 5873.7944171954205, 5890.646561206341, 5894.734736936848, 24033.639495407584, 25125.37186570332, 25515.74484255152, 25814.838332274903, 26090.86954565215, 2566.4353842154696, 2595.974040259592, 2620.423506828514, 2629.6975847777367, 2681.410089780245, 10024.94987525065, 10177.949110254476, 10508.422036787973, 12498.437570309357, 15627.45303914369, 1774.325756212644, 1803.1074618064142, 1812.4925020994142, 1817.2458429751637, 1823.5714607067328, 97837.0, 140107.59892401047, 144326.27836860853, 144865.0, 146802.26598867044, 9666.661666841626, 11901.166918315635, 11908.46411911466, 11999.280043197436, 12010.279383237033, 13065.412056457482, 15848.683026339639, 15899.761503577225, 15948.441804537018, 15955.680886382208, 8739.912600874037, 8869.556522173865, 8898.59956301968, 8930.240929520933, 9031.548422578844, 7652.579108148994, 8208.343332533503, 8693.130686931256, 8705.608247628872, 8836.8674469883, 3975.8210880510446, 4650.883727906762, 4776.567029891019, 4782.115308667908, 4871.975640121847, 1961.2939341836927, 2008.8192062714427, 2010.4169790760516, 2011.7787043425212, 2018.5357367805486, 410.30043775362935, 416.55428691300017, 426.1604638861438, 831.5966756123275, 890.950997695133, 11910.46402911871, 12134.193419839998, 12311.56909508163, 12401.875981240071, 12456.501739930483, 447.0723249257803, 447.16826702333634, 460.5233583241396, 464.1876715747442, 473.25462396724606, 5933.169356290123, 6006.939930600725, 6110.175126357974, 6277.937220627735, 6278.497720182374, 719934.0, 727967.4447205232, 734172.0, 743155.0, 756792.0, 99205.51986200403, 119356.0, 129469.35265323802, 144101.838472423, 158450.20774896283, 449.64028776978284, 466.249338564917, 467.7707923117648, 467.81988934260556, 469.66419010407725, 10258.487075646039, 10559.524821382902, 11714.88285117138, 11794.410279486163, 12133.332666703416, 50062.749686251336, 59400.70299648474, 59774.310156042215, 59793.701031496304, 59855.73574768645, 82031.35937281101, 82407.5879620598, 85099.5745021271, 85398.57300713456, 85471.71792423243, 7731.342835859015, 8165.0, 8228.50628962264, 8420.789480262798, 8484.321254299517, 10988.945055274673, 12794.424250908918, 12873.485060597472, 13324.133931294435, 13386.397612107674, 11027.669169924915, 11084.057855082408, 11210.663680089285, 11279.770086217668, 11449.0, 10322.12261957742, 10524.947375263075, 10545.261831671709, 11478.196526243082, 11625.36060516646, 11239.157063220455, 11343.886561134614, 11429.0, 11480.712982175512, 11777.293362398283, 8247.628856701343, 8295.751127466187, 8387.245147936716, 8482.982042154981, 8492.363072769444, 8430.36772242072, 10945.890541094486, 10959.835602466128, 11214.831777523506, 11420.543178273108], "value": 8960.403993195328, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.9453621855125, 1416.5537855575492, 1422.0259122501093, 1431.9140851548905, 1433.2976841347736, 8033.87949180762, 8446.57767111645, 8453.957730211348, 8460.238578527931, 8464.492130472176, 7487.1764105948305, 7723.0, 7727.845443091135, 8037.517748935068, 8332.958335208315, 2297.529006553661, 2349.530093981202, 2356.587597170488, 2366.514864452783, 2367.9408014799596, 2305.400595845084, 2339.6022676145094, 2345.3901985483812, 2347.6243800991847, 2361.0083764818733, 1874.0, 2033.2781862438844, 2107.1571371451387, 2336.2056900653774, 2363.5745565798147, 2309.214866945238, 2327.569399661068, 2327.988360058189, 2328.0222306631254, 2328.499372634883, 1871.5695390060225, 2341.8829058547003, 2347.7534858839745, 2364.4916342986166, 2369.893354799038, 8293.585320733999, 8363.58182090893, 8370.414071015031, 8381.413301068927, 8386.664533418656, 4372.89067773305, 5093.719845408501, 5256.448072952323, 5276.894462110775, 5279.736013199325, 3360.22714775603, 3546.840392182358, 3570.589382221052, 3582.4805403216646, 3652.141746689526, 1053.2364036073861, 1182.1724792645098, 1212.9575464858688, 1252.0922331309728, 1269.7587458382877, 10338.328008679488, 10583.417912014836, 10585.153187744962, 10610.681679549549, 10750.193735469793, 4475.216837053503, 4530.637548996073, 4584.587387135174, 4588.242939914943, 4589.954100458953, 8771.561421928878, 8791.032986371494, 8797.944246690438, 8802.163794439519, 8808.20726134638, 5185.585153187736, 5187.584993200535, 5197.402298735694, 5199.324087868553, 5208.817691380784, 4782.497837727058, 4796.37647105874, 4854.0, 4912.631552633567, 4935.827246046371, 3683.3922402803237, 3788.2802267569073, 3797.8290976906105, 3837.0, 3854.5567259764925, 1157.4617802721775, 1165.5920427850185, 1176.9646910592696, 1177.5231031432284, 1188.5839956015498, 856.4133568505594, 858.9098144694842, 868.8827008353918, 882.188386684252, 895.2479916869861, 5108.795648174031, 5305.204219367126, 5367.436419176009, 5393.541548968382, 5399.055165346049, 533.093740640912, 545.62079354848, 550.8898220355945, 572.3275151696823, 579.1920271221622, 3287.6876696713775, 3500.212452198286, 3551.911202219965, 3596.226811235597, 3596.82015899204, 9680.27397945143, 10023.0, 10035.448050357301, 10040.146587539995, 10069.848952265722, 9926.553305101288, 9970.950145249228, 10035.799284014425, 10037.447940363205, 10044.547995340226, 7279.199288078307, 7537.924620753723, 7649.694012239559, 7728.999999999887, 7741.419393545507, 5229.111051121395, 5230.503102205284, 5268.394134674408, 5360.946390536044, 5435.0, 7839.921600784147, 8978.236849867573, 9386.202172815387, 9408.43549387039, 9419.905800941902, 8525.360597955303, 8866.335024873031, 9095.408798428081, 9284.02517735628, 9473.621055157717, 6721.294264102199, 6736.629485378351, 7280.344768970818, 7280.745173918887, 7281.162666293232, 7878.369730421668, 7944.205579442009, 8035.919640803517, 8042.155573664915, 8058.717944871902, 7031.472639551952, 7104.786856394317, 7186.317299856505, 7225.674844632109, 7281.890771638536, 7053.682584283617, 7081.291870812877, 7084.574925504487, 7120.857582848417, 7172.175199852084, 6395.616263024233, 6416.807495775134, 6451.387118223761, 6533.118029066015, 6547.345265473415, 3672.7429079964145, 4805.159097158054, 4847.636427267898, 4852.902941941212, 5028.296038554532, 4851.369321988119, 4939.53074457926, 4968.975155124202, 4981.078500477423, 4983.127952608352], "value": 4296.29258195946, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.1845386533666, 348.7262498938333, 355.4313099041534, 377.556371263765, 380.97142714296416, 4579.107074120544, 5244.292020577221, 5293.52358287754, 5304.0, 5308.70802105884, 4207.1084247071485, 4954.628402869781, 5118.718470484131, 5126.692398456095, 5215.3832311983315, 3314.850831712579, 3464.8094354810473, 4090.997705562134, 4141.254574176647, 4170.937435938464, 4132.524759652633, 4136.441580386654, 4151.294279972412, 4171.769328048233, 4193.0984838259765, 3995.8622137156626, 4049.4533238012787, 4107.691923105779, 4112.650424713903, 4154.792260386984, 4077.3883917412327, 4082.5713300103357, 4085.5914408558906, 4097.385392191195, 4102.2821006324075, 3023.183740390082, 3040.802347847405, 3609.981950090259, 3611.6207798181076, 3646.4348026055736, 4318.747563206666, 4489.236829738952, 4710.222813235846, 4890.902181956341, 5207.578476008674, 4676.36869022681, 4695.953040469586, 4738.2892566115015, 4744.410622441486, 4753.548412900804, 4676.223035246619, 5464.338892941739, 5528.530074943635, 5529.529989950859, 5558.332500249909, 3252.5283833844196, 3380.932381352384, 4036.979815100906, 4038.8586399475876, 4052.371882358239, 4074.5314288856566, 5616.02350754101, 5716.971415142898, 5762.049261871828, 5839.8540036499, 3738.2336620992633, 3848.826802793881, 4081.10215752534, 4108.4453598763785, 4114.670826333886, 3954.8813535593977, 4180.958190418118, 4185.6232939035635, 4193.706440549193, 4207.990082380206, 4147.6267135957305, 4560.566746159109, 4661.440627124767, 4753.667243292936, 4757.785899634525, 4668.906621867543, 5090.669106508065, 5534.889302214014, 5574.247476590689, 5580.637258578179, 1297.7339645372676, 1339.8325209348832, 1352.2224720785587, 1359.2252416122715, 1372.9382177802022, 834.7036801935348, 894.7250168509847, 933.332667142996, 934.8737920380797, 947.2327414793901, 4502.909941801146, 4944.357233559686, 5055.0, 5058.519440653132, 5063.620228482879, 4762.285657151386, 4785.401824771903, 5443.768055097391, 5566.970110529565, 5641.746121424546, 4239.51245606753, 4440.666949978699, 4710.929336059962, 4919.327428674196, 4968.602511799119, 2442.009762043964, 2449.860814721163, 2720.1295585412477, 2851.7148285171734, 2933.911982640524, 4579.7252164870215, 4618.745968971672, 5398.546199385444, 5666.186820217573, 5745.68398738065, 4796.424429068465, 5182.056728726728, 5387.276071657032, 5591.384947655754, 5626.468089359722, 4925.24186455586, 5178.430372659004, 5660.405657405995, 5709.7430615623225, 5713.800101978631, 5130.384353877558, 5347.850212204395, 5358.97320513395, 5374.811881584125, 5378.892422151614, 4587.954120458753, 4905.9018819624125, 4925.975370123127, 4994.951060277383, 5317.521423071942, 5211.5049070338255, 5471.644343117685, 5575.4424557543925, 5643.0249412705225, 5662.688552129673, 3365.495175723661, 3443.1651992972766, 3575.6066832648908, 3899.7075219358094, 3908.2965066288343, 4518.096380723934, 5178.689278643294, 5311.486226425604, 5313.0, 5360.839174824761, 4629.60648344881, 4823.118983596471, 5188.195829646411, 5196.896062078662, 5231.175165410636, 4160.439835061852, 4869.878253043702, 5079.415867175175, 5202.063628546898, 5293.338332708411, 4203.453551038346, 4430.468343798636, 5107.004134193797, 5216.452272511332, 5419.701916394636, 4791.520847915181, 4931.778069986931, 5515.22786809855, 5544.279243698294, 5672.2342483765815, 4473.888152796076, 5436.700981446058, 5451.936872310021, 5460.34475862899, 5467.234587157881], "value": 3988.2846832941327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.2403989750918, 730.1967835381079, 767.9078510578728, 813.101522817287, 821.0639870547575, 14642.414303427864, 15480.148591827445, 15502.68994620107, 15519.456819011337, 15529.301181446834, 14288.428462861499, 14293.928530357334, 14304.141751494917, 14354.497592584261, 14474.782878256834, 684.2473279392678, 701.8876979683251, 850.8893843800297, 860.7805009722528, 875.4615911214621, 680.4590350671228, 871.424859592669, 877.6313948141795, 878.1043335797483, 880.1110878013221, 944.759086432962, 945.877035985321, 945.957431915562, 947.0624082158648, 947.8530827721714, 730.477708438469, 751.9924800751977, 942.4533770413144, 944.8582712593166, 945.4091193004373, 672.5863593889771, 686.6017709728345, 697.1808125452624, 697.9092717946635, 698.7170196070599, 14958.681404382229, 15198.848011519854, 15203.695926081416, 15204.46784362542, 15239.923800381039, 13652.522161724391, 13694.52069177584, 13695.657608559766, 13719.0, 14147.717045659132, 10942.0, 11514.712132196762, 12275.447604857714, 12527.997760179163, 12851.35743212845, 4301.0, 4351.5648435156545, 4399.802008909607, 4447.822087116511, 4467.798949047268, 100340.49829750805, 100965.0, 102668.0, 103427.44858827123, 103871.0, 8980.595873185723, 10506.789864202674, 10655.520501577448, 10795.838062428913, 10938.56245750161, 20581.794182058286, 20956.161753529992, 20956.26653067166, 21042.947852607307, 21285.78714212869, 7279.781606551812, 7563.357114645317, 7685.269899359552, 7784.571848548384, 7830.765077047698, 4143.81352839123, 4158.209940111369, 4218.367244913287, 4230.809613567397, 4299.94651310431, 3407.454807230831, 3486.2678837443914, 3491.4064609016527, 3500.64993500653, 3504.491848681927, 633.5691729623808, 640.6316368088368, 642.787879999599, 653.9313372095957, 657.4871600151889, 518.3934796288352, 519.5220397234477, 524.9895002099937, 525.3092183778319, 539.5629540072554, 9282.72151835446, 9746.0, 9843.188646997587, 9908.554115064839, 9983.351082179635, 543.1581049373534, 543.8504411286928, 569.6012791046285, 579.507418694115, 607.875385545962, 4094.4267802507675, 4343.522212556616, 4935.0779065122, 4950.43070046942, 4980.850574482772, 92939.53530232306, 94670.52664736632, 95824.56263156058, 96703.51648241855, 99452.0, 72957.0, 74838.25161748422, 82119.0, 83664.58167709122, 84144.0, 73133.0, 74181.0, 74471.88292175731, 74584.0, 75903.0, 9459.243260539279, 9535.570899309409, 9542.522873856418, 9572.664956726481, 9576.090271424204, 46741.2988805175, 47906.520934790206, 48057.279140812214, 49032.0, 49115.50884491109, 55335.44664553464, 55744.72127639336, 59657.701711491165, 63751.6812415935, 65225.02162467472, 12829.550965716155, 13035.0, 13215.273159975908, 13380.0, 13834.239116848268, 14125.293735313398, 14363.0, 14998.175100369584, 15040.247987600795, 15504.689906202038, 11972.281663100242, 12523.185992910432, 12895.742085158432, 13239.536616218385, 13609.93195034058, 12962.740745184854, 13699.178049317074, 13860.306984650928, 13886.791698124334, 14179.645508861948, 12192.329421881881, 13373.264470454218, 13376.665583360495, 13505.0, 13625.454981801013, 7880.645370958206, 10773.946130269298, 10898.782024359627, 11218.382988935688, 11558.537658493902, 8347.58262086881, 8897.866532001895, 9572.593247163253, 10853.45732713377, 10870.782584348111], "value": 7286.130463945366, "unit": "score"}], "name": "dromaeo_css", "value": 7122.667235461696, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 139.0, 123.0, 160.0, 93.0, 110.0, 127.0, 137.0, 153.0, 108.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 183.0, 183.0, 185.0, 181.0, 184.0, 185.0, 183.0, 182.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 61.0, 58.0, 82.0, 57.0, 61.0, 78.0, 82.0, 97.0, 83.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 85.0, 73.0, 95.0, 100.0, 114.0, 67.0, 69.0, 82.0], "value": 84.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 85.0, 88.0, 131.0, 87.0, 84.0, 87.0, 84.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 169.0, 96.0, 97.0, 99.0, 98.0, 96.0, 96.0, 98.0, 95.0], "value": 109.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 95.0, 129.0, 86.0, 89.0, 87.0, 85.0, 85.0, 87.0], "value": 91.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 56.0, 57.0, 57.0, 57.0, 57.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 75.0, 72.0, 72.0, 68.0, 69.0, 69.0, 68.0, 94.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 87.0, 84.0, 84.0, 72.0, 94.0, 73.0, 89.0, 102.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 170.0, 152.0, 145.0, 138.0, 139.0, 140.0, 140.0, 256.0, 147.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 167.0, 169.0, 171.0, 167.0, 171.0, 228.0, 197.0, 167.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 65.0, 65.0, 64.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1494.1000000000001, "alertThreshold": 2.0}]} 11:32:38 INFO - Return code: 0 11:32:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:32:38 ERROR - # TBPL SUCCESS # 11:32:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:32:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:32:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:32:38 INFO - 2017-02-22 11:32:38.571 screenresolution[1647:9716] starting screenresolution argv=screenresolution get 11:32:38 INFO - 2017-02-22 11:32:38.574 screenresolution[1647:9716] Display 0: 1600x1200x32@60 11:32:38 INFO - 2017-02-22 11:32:38.581 screenresolution[1648:9720] starting screenresolution argv=screenresolution list 11:32:38 INFO - Available Modes on Display 0 11:32:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:32:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:32:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:32:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:32:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:32:38 INFO - Intel Iris: 11:32:38 INFO - Chipset Model: Intel Iris 11:32:38 INFO - Type: GPU 11:32:38 INFO - Bus: Built-In 11:32:38 INFO - VRAM (Dynamic, Max): 1536 MB 11:32:38 INFO - Vendor: Intel (0x8086) 11:32:38 INFO - Device ID: 0x0a2e 11:32:38 INFO - Revision ID: 0x0009 11:32:38 INFO - Displays: 11:32:38 INFO - Display: 11:32:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:32:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:32:38 INFO - Display Serial Number: 1600x1200 60 11:32:38 INFO - Main Display: Yes 11:32:38 INFO - Mirror: Off 11:32:38 INFO - Online: Yes 11:32:38 INFO - Rotation: Supported 11:32:38 INFO - Return code: 0 11:32:38 INFO - Running post-action listener: _resource_record_post_action 11:32:38 INFO - [mozharness: 2017-02-22 19:32:38.822084Z] Finished run-tests step (success) 11:32:38 INFO - Running post-run listener: _resource_record_post_run 11:32:38 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 39273472; Write bytes: 509806080; Read time: 380; Write time: 1768 11:32:38 INFO - TinderboxPrint: CPU usage
53.6% 11:32:38 INFO - TinderboxPrint: I/O read bytes / time
39,273,472 / 380 11:32:38 INFO - TinderboxPrint: I/O write bytes / time
509,806,080 / 1,768 11:32:38 INFO - TinderboxPrint: CPU idle
2,227.5 (46.4%) 11:32:38 INFO - TinderboxPrint: CPU system
954.6 (19.9%) 11:32:38 INFO - TinderboxPrint: CPU user
1,615.5 (33.7%) 11:32:38 INFO - TinderboxPrint: Swap in / out
246,624,256 / 0 11:32:38 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 200356352; Write bytes: 201914368; Read time: 15479; Write time: 493 11:32:38 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 38319104; Write bytes: 298065408; Read time: 366; Write time: 1246 11:32:39 INFO - Running post-run listener: _upload_blobber_files 11:32:39 INFO - Blob upload gear active. 11:32:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:32:39 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 11:32:39 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:32:39 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:32:39 INFO - (blobuploader) - INFO - Open directory for files ... 11:32:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:32:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:32:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:41 INFO - (blobuploader) - INFO - Done attempting. 11:32:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:32:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:32:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:42 INFO - (blobuploader) - INFO - Done attempting. 11:32:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:32:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:32:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:43 INFO - (blobuploader) - INFO - Done attempting. 11:32:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:32:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:32:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:46 INFO - (blobuploader) - INFO - Done attempting. 11:32:46 INFO - (blobuploader) - INFO - Iteration through files over. 11:32:46 INFO - Return code: 0 11:32:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:32:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:32:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a93126278a9755219d1dc8a5a239998122daf88c987bb80b9901157f10722a713701d42b368e7b63026250144c90f1c855c6ee9be873c335522735eb1376fd2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb59704e4b5dd28fc48a168715b9865b0d74ffbc77b5aadca68abb01a960c5d255b195a0eb80ee19788ff07d2afd539cc61074a3fab45449e88288b219e2690b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5148e5914b9bf083461be73827c1c19eb6c700d166e2dd26a11742dbc263eb866d0715d252c974006865cf21f18437b6d026f7e74d6a7866b561e47c17aebd10", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49082a626b0bad05b65a6111240e0a513bedb271361cce6a94a943524e274f12c31ac32a9f45c51814f5868adf6f6534641795860dc6f355b3c178052e4857fb"} 11:32:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:32:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:32:46 INFO - Contents: 11:32:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a93126278a9755219d1dc8a5a239998122daf88c987bb80b9901157f10722a713701d42b368e7b63026250144c90f1c855c6ee9be873c335522735eb1376fd2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb59704e4b5dd28fc48a168715b9865b0d74ffbc77b5aadca68abb01a960c5d255b195a0eb80ee19788ff07d2afd539cc61074a3fab45449e88288b219e2690b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5148e5914b9bf083461be73827c1c19eb6c700d166e2dd26a11742dbc263eb866d0715d252c974006865cf21f18437b6d026f7e74d6a7866b561e47c17aebd10", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49082a626b0bad05b65a6111240e0a513bedb271361cce6a94a943524e274f12c31ac32a9f45c51814f5868adf6f6534641795860dc6f355b3c178052e4857fb"} 11:32:46 INFO - Running post-run listener: copy_logs_to_upload_dir 11:32:46 INFO - Copying logs to upload dir... 11:32:46 INFO - mkdir: /builds/slave/test/build/upload/logs 11:32:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.202171 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-22 11:32:46.818374) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 11:32:46.824032) ========= 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.jOScjViRRT/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.LrBkfgrGoq/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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/Mozilla-Aurora/sha512/a93126278a9755219d1dc8a5a239998122daf88c987bb80b9901157f10722a713701d42b368e7b63026250144c90f1c855c6ee9be873c335522735eb1376fd2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb59704e4b5dd28fc48a168715b9865b0d74ffbc77b5aadca68abb01a960c5d255b195a0eb80ee19788ff07d2afd539cc61074a3fab45449e88288b219e2690b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5148e5914b9bf083461be73827c1c19eb6c700d166e2dd26a11742dbc263eb866d0715d252c974006865cf21f18437b6d026f7e74d6a7866b561e47c17aebd10", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49082a626b0bad05b65a6111240e0a513bedb271361cce6a94a943524e274f12c31ac32a9f45c51814f5868adf6f6534641795860dc6f355b3c178052e4857fb"} build_url:https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011520 build_url: 'https://queue.taskcluster.net/v1/task/TQw4y1JbQVqOuYP1tQ18Eg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a93126278a9755219d1dc8a5a239998122daf88c987bb80b9901157f10722a713701d42b368e7b63026250144c90f1c855c6ee9be873c335522735eb1376fd2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb59704e4b5dd28fc48a168715b9865b0d74ffbc77b5aadca68abb01a960c5d255b195a0eb80ee19788ff07d2afd539cc61074a3fab45449e88288b219e2690b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5148e5914b9bf083461be73827c1c19eb6c700d166e2dd26a11742dbc263eb866d0715d252c974006865cf21f18437b6d026f7e74d6a7866b561e47c17aebd10", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49082a626b0bad05b65a6111240e0a513bedb271361cce6a94a943524e274f12c31ac32a9f45c51814f5868adf6f6534641795860dc6f355b3c178052e4857fb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 11:32:46.856387) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 11:32:46.856774) ========= 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.jOScjViRRT/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.LrBkfgrGoq/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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.005190 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 11:32:46.905387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 11:32:46.905711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 11:32:46.906080) ========= ========= Total master_lag: 0.23 =========