builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0369 starttime: 1486847234.09 results: success (0) buildid: 20170211070119 builduid: 096a99c790604e5a8589855fdbcde721 revision: 8a64bfa2d3564c97bb67710f479a0fc4ccc4a08b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-11 13:07:14.085801) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-11 13:07:14.086240) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-11 13:07:14.086538) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-11 13:07:14.113340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 13:07:14.113806) ========= 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.MwLbrVfNLC/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.jaANf9CNTq/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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-11 13:07:14-- 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% 18.1M=0.001s 2017-02-11 13:07:14 (18.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.495456 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 13:07:14.633361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 13:07:14.633698) ========= 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.MwLbrVfNLC/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.jaANf9CNTq/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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.026130 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 13:07:14.682208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 19 secs) (at 2017-02-11 13:07:14.682588) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8a64bfa2d3564c97bb67710f479a0fc4ccc4a08b --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 8a64bfa2d3564c97bb67710f479a0fc4ccc4a08b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MwLbrVfNLC/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.jaANf9CNTq/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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-11 13:07:14,788 truncating revision to first 12 chars 2017-02-11 13:07:14,788 Setting DEBUG logging. 2017-02-11 13:07:14,788 attempt 1/10 2017-02-11 13:07:14,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8a64bfa2d356?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-11 13:07:33,714 unpacking tar archive at: mozilla-aurora-8a64bfa2d356/testing/mozharness/ program finished with exit code 0 elapsedTime=19.203261 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 19 secs) (at 2017-02-11 13:07:33.912664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-11 13:07:33.913502) ========= script_repo_revision: 8a64bfa2d3564c97bb67710f479a0fc4ccc4a08b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-11 13:07:33.914560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-11 13:07:33.915311) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-11 13:07:33.936867) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-11 13:07:33.937638) ========= /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.MwLbrVfNLC/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.jaANf9CNTq/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 13:07:34 INFO - MultiFileLogger online at 20170211 13:07:34 in /builds/slave/test 13:07:34 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 13:07:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:07:34 INFO - {'append_to_log': False, 13:07:34 INFO - 'base_work_dir': '/builds/slave/test', 13:07:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:07:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:07:34 INFO - 'branch': 'Mozilla-Aurora', 13:07:34 INFO - 'buildbot_json_path': 'buildprops.json', 13:07:34 INFO - 'config_files': ('talos/mac_config.py',), 13:07:34 INFO - 'default_actions': ('clobber', 13:07:34 INFO - 'read-buildbot-config', 13:07:34 INFO - 'download-and-extract', 13:07:34 INFO - 'populate-webroot', 13:07:34 INFO - 'create-virtualenv', 13:07:34 INFO - 'install', 13:07:34 INFO - 'run-tests'), 13:07:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:07:34 INFO - 'download_minidump_stackwalk': True, 13:07:34 INFO - 'download_symbols': 'ondemand', 13:07:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:07:34 INFO - 'tooltool.py': '/tools/tooltool.py', 13:07:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:07:34 INFO - '/tools/misc-python/virtualenv.py')}, 13:07:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:07:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:07:34 INFO - 'installer_path': 'installer.exe', 13:07:34 INFO - 'log_level': 'info', 13:07:34 INFO - 'log_name': 'talos', 13:07:34 INFO - 'log_to_console': True, 13:07:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:07:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:07:34 INFO - 'opt_config_files': (), 13:07:34 INFO - 'pip_index': False, 13:07:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:07:34 INFO - 'cmd': ('bash', 13:07:34 INFO - '-c', 13:07:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:07:34 INFO - 'enabled': True, 13:07:34 INFO - 'halt_on_failure': False, 13:07:34 INFO - 'name': 'check_screen_resolution'},), 13:07:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:07:34 INFO - 'cmd': ('bash', 13:07:34 INFO - '-c', 13:07:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:07:34 INFO - 'enabled': True, 13:07:34 INFO - 'halt_on_failure': False, 13:07:34 INFO - 'name': 'check_screen_resolution'},), 13:07:34 INFO - 'run_cmd_checks_enabled': True, 13:07:34 INFO - 'sps_profile': False, 13:07:34 INFO - 'sps_profile_interval': 0, 13:07:34 INFO - 'suite': 'dromaeojs', 13:07:34 INFO - 'system_bits': '32', 13:07:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:07:34 INFO - 'title': 't-yosemite-r7-0369', 13:07:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:07:34 INFO - 'use_talos_json': True, 13:07:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:07:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:07:34 INFO - 'work_dir': 'build'} 13:07:34 INFO - [mozharness: 2017-02-11 21:07:34.150886Z] Running clobber step. 13:07:34 INFO - Running pre-action listener: _resource_record_pre_action 13:07:34 INFO - Running main action method: clobber 13:07:34 INFO - rmtree: /builds/slave/test/build 13:07:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:07:36 INFO - Running post-action listener: _resource_record_post_action 13:07:36 INFO - [mozharness: 2017-02-11 21:07:36.589035Z] Finished clobber step (success) 13:07:36 INFO - [mozharness: 2017-02-11 21:07:36.589114Z] Running read-buildbot-config step. 13:07:36 INFO - Running pre-action listener: _resource_record_pre_action 13:07:36 INFO - Running main action method: read_buildbot_config 13:07:36 INFO - Using buildbot properties: 13:07:36 INFO - { 13:07:36 INFO - "project": "", 13:07:36 INFO - "product": "firefox", 13:07:36 INFO - "script_repo_revision": "production", 13:07:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:07:36 INFO - "repository": "", 13:07:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:07:36 INFO - "buildid": "20170211070119", 13:07:36 INFO - "pgo_build": "False", 13:07:36 INFO - "basedir": "/builds/slave/test", 13:07:36 INFO - "buildnumber": 0, 13:07:36 INFO - "slavename": "t-yosemite-r7-0369", 13:07:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:07:36 INFO - "platform": "yosemite_r7", 13:07:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:07:36 INFO - "branch": "mozilla-aurora", 13:07:36 INFO - "repo_path": "releases/mozilla-aurora", 13:07:36 INFO - "revision": "8a64bfa2d3564c97bb67710f479a0fc4ccc4a08b", 13:07:36 INFO - "stage_platform": "macosx64", 13:07:36 INFO - "builduid": "096a99c790604e5a8589855fdbcde721", 13:07:36 INFO - "slavebuilddir": "test" 13:07:36 INFO - } 13:07:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 13:07:36 INFO - Running post-action listener: _resource_record_post_action 13:07:36 INFO - [mozharness: 2017-02-11 21:07:36.592478Z] Finished read-buildbot-config step (success) 13:07:36 INFO - [mozharness: 2017-02-11 21:07:36.592615Z] Running download-and-extract step. 13:07:36 INFO - Running pre-action listener: _resource_record_pre_action 13:07:36 INFO - Running main action method: download_and_extract 13:07:36 INFO - mkdir: /builds/slave/test/build/tests 13:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:36 INFO - trying https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 13:07:36 INFO - Downloading https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/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 13:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/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 13:07:38 INFO - Downloaded 1199 bytes. 13:07:38 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 13:07:38 INFO - Using the following test package requirements: 13:07:38 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 13:07:38 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:07:38 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 13:07:38 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:07:38 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 13:07:38 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:07:38 INFO - u'jsshell-mac.zip'], 13:07:38 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:07:38 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 13:07:38 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 13:07:38 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:07:38 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 13:07:38 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:07:38 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 13:07:38 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:07:38 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 13:07:38 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:07:38 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 13:07:38 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:07:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 13:07:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:07:38 INFO - Fetch https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 13:07:38 INFO - Expected file size: 16358202 13:07:38 INFO - Obtained file size: 16358202 13:07:45 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 13:07:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 13:07:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:07:45 INFO - Fetch https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 13:07:46 INFO - Expected file size: 16358202 13:07:46 INFO - Obtained file size: 16358202 13:07:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 13:07:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:07:53 INFO - Fetch https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 13:07:54 INFO - Expected file size: 14403485 13:07:54 INFO - Obtained file size: 14403485 13:07:54 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')]} 13:07:54 INFO - trying https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:07:54 INFO - Downloading https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 13:07:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/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 13:07:56 INFO - Downloaded 73854522 bytes. 13:07:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:07:56 INFO - mkdir: /builds/slave/test/properties 13:07:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:07:56 INFO - Writing to file /builds/slave/test/properties/build_url 13:07:56 INFO - Contents: 13:07:56 INFO - build_url:https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:07:57 INFO - Running post-action listener: _resource_record_post_action 13:07:57 INFO - Running post-action listener: set_extra_try_arguments 13:07:57 INFO - [mozharness: 2017-02-11 21:07:57.446283Z] Finished download-and-extract step (success) 13:07:57 INFO - [mozharness: 2017-02-11 21:07:57.446407Z] Running populate-webroot step. 13:07:57 INFO - Running pre-action listener: _resource_record_pre_action 13:07:57 INFO - Running main action method: populate_webroot 13:07:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:07:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:07:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:07:57 INFO - '--tppagecycles', 13:07:57 INFO - '7'], 13:07:57 INFO - 'tests': ['tsvgm']}}, 13:07:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:07:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:07:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:07:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:07:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:07:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:07:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:07:57 INFO - 'talos_options': ['--disable-e10s'], 13:07:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:07:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:07:57 INFO - 'talos_options': ['--disable-e10s'], 13:07:57 INFO - 'tests': ['damp', 'tps']}, 13:07:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:07:57 INFO - 'tests': ['damp', 'tps']}, 13:07:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:07:57 INFO - 'tests': ['dromaeo_dom']}, 13:07:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:07:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:07:57 INFO - 'tests': ['basic_compositor_video']}, 13:07:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:07:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:07:57 INFO - 'tests': ['a11yr', 13:07:57 INFO - 'ts_paint', 13:07:57 INFO - 'tpaint', 13:07:57 INFO - 'sessionrestore', 13:07:57 INFO - 'sessionrestore_no_auto_restore', 13:07:57 INFO - 'tabpaint']}, 13:07:57 INFO - 'other-e10s': {'tests': ['a11yr', 13:07:57 INFO - 'ts_paint', 13:07:57 INFO - 'tpaint', 13:07:57 INFO - 'sessionrestore', 13:07:57 INFO - 'sessionrestore_no_auto_restore', 13:07:57 INFO - 'tabpaint']}, 13:07:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:07:57 INFO - 'ts_paint', 13:07:57 INFO - 'tpaint', 13:07:57 INFO - 'sessionrestore', 13:07:57 INFO - 'sessionrestore_no_auto_restore', 13:07:57 INFO - 'tabpaint']}, 13:07:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:07:57 INFO - 'ts_paint', 13:07:57 INFO - 'tpaint', 13:07:57 INFO - 'sessionrestore', 13:07:57 INFO - 'sessionrestore_no_auto_restore', 13:07:57 INFO - 'tabpaint']}, 13:07:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:07:57 INFO - 'tests': ['a11yr', 13:07:57 INFO - 'ts_paint', 13:07:57 INFO - 'tpaint', 13:07:57 INFO - 'sessionrestore', 13:07:57 INFO - 'sessionrestore_no_auto_restore', 13:07:57 INFO - 'tabpaint']}, 13:07:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:07:57 INFO - 'tests': ['a11yr', 13:07:57 INFO - 'ts_paint', 13:07:57 INFO - 'tpaint', 13:07:57 INFO - 'sessionrestore', 13:07:57 INFO - 'sessionrestore_no_auto_restore', 13:07:57 INFO - 'tabpaint']}, 13:07:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:07:57 INFO - 'tests': ['tsvgx', 13:07:57 INFO - 'tsvgr_opacity', 13:07:57 INFO - 'tart', 13:07:57 INFO - 'tscrollx', 13:07:57 INFO - 'cart', 13:07:57 INFO - 'tsvg_static']}, 13:07:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:07:57 INFO - 'tsvgr_opacity', 13:07:57 INFO - 'tart', 13:07:57 INFO - 'tscrollx', 13:07:57 INFO - 'cart', 13:07:57 INFO - 'tsvg_static']}, 13:07:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:07:57 INFO - 'talos_options': ['--disable-e10s'], 13:07:57 INFO - 'tests': ['tp5o']}, 13:07:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:07:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:07:57 INFO - 'talos_options': ['--disable-e10s', 13:07:57 INFO - '--xperf_path', 13:07:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:57 INFO - 'tests': ['tp5n']}, 13:07:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:07:57 INFO - 'talos_options': ['--xperf_path', 13:07:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:57 INFO - 'tests': ['tp5n']}}, 13:07:57 INFO - 'talos.zip': {'path': '', 13:07:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:07:57 INFO - Running post-action listener: _resource_record_post_action 13:07:57 INFO - [mozharness: 2017-02-11 21:07:57.464865Z] Finished populate-webroot step (success) 13:07:57 INFO - [mozharness: 2017-02-11 21:07:57.465001Z] Running create-virtualenv step. 13:07:57 INFO - Running pre-action listener: _resource_record_pre_action 13:07:57 INFO - Running main action method: create_virtualenv 13:07:57 INFO - Creating virtualenv /builds/slave/test/build/venv 13:07:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:07:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:07:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:07:57 INFO - Using real prefix '/tools/python27' 13:07:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:07:58 INFO - Installing distribute.............................................................................................................................................................................................done. 13:08:01 INFO - Installing pip.................done. 13:08:01 INFO - Return code: 0 13:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:08:01 INFO - Reading from file tmpfile_stdout 13:08:01 INFO - Output received: 13:08:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:08:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e713b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e716768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7435a5340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f1d30>, '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 0x10e418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4e6be8>, '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.MwLbrVfNLC/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.jaANf9CNTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 13:08:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:08:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MwLbrVfNLC/Render', 13:08:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:01 INFO - 'HOME': '/Users/cltbld', 13:08:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:01 INFO - 'LOGNAME': 'cltbld', 13:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:01 INFO - 'MOZ_NO_REMOTE': '1', 13:08:01 INFO - 'NO_EM_RESTART': '1', 13:08:01 INFO - 'PAGER': '/bin/cat', 13:08:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:01 INFO - 'PWD': '/builds/slave/test', 13:08:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:01 INFO - 'SHELL': '/bin/bash', 13:08:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaANf9CNTq/Listeners', 13:08:01 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 13:08:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:01 INFO - 'USER': 'cltbld', 13:08:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:01 INFO - 'XPC_FLAGS': '0x0', 13:08:01 INFO - 'XPC_SERVICE_NAME': '0', 13:08:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:01 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 13:08:01 INFO - Cleaning up... 13:08:01 INFO - Return code: 0 13:08:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e713b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e716768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7435a5340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f1d30>, '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 0x10e418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4e6be8>, '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.MwLbrVfNLC/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.jaANf9CNTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 13:08:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:08:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MwLbrVfNLC/Render', 13:08:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:01 INFO - 'HOME': '/Users/cltbld', 13:08:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:01 INFO - 'LOGNAME': 'cltbld', 13:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:01 INFO - 'MOZ_NO_REMOTE': '1', 13:08:01 INFO - 'NO_EM_RESTART': '1', 13:08:01 INFO - 'PAGER': '/bin/cat', 13:08:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:01 INFO - 'PWD': '/builds/slave/test', 13:08:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:01 INFO - 'SHELL': '/bin/bash', 13:08:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaANf9CNTq/Listeners', 13:08:01 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 13:08:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:01 INFO - 'USER': 'cltbld', 13:08:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:01 INFO - 'XPC_FLAGS': '0x0', 13:08:01 INFO - 'XPC_SERVICE_NAME': '0', 13:08:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:01 INFO - Downloading/unpacking psutil>=3.1.1 13:08:01 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 13:08:01 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 13:08:01 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 13:08:01 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 13:08:01 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 13:08:01 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 13:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:08:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:06 INFO - Installing collected packages: psutil 13:08:06 INFO - Running setup.py install for psutil 13:08:06 INFO - building 'psutil._psutil_osx' extension 13:08:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:08:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:08:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:08:06 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 13:08:06 INFO - building 'psutil._psutil_posix' extension 13:08:06 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 13:08:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:08:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:08:06 INFO - ^ 13:08:07 INFO - 1 warning generated. 13:08:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:08:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:07 INFO - Successfully installed psutil 13:08:07 INFO - Cleaning up... 13:08:07 INFO - Return code: 0 13:08:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e713b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e716768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7435a5340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f1d30>, '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 0x10e418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4e6be8>, '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.MwLbrVfNLC/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.jaANf9CNTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 13:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MwLbrVfNLC/Render', 13:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:07 INFO - 'HOME': '/Users/cltbld', 13:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:07 INFO - 'LOGNAME': 'cltbld', 13:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:07 INFO - 'MOZ_NO_REMOTE': '1', 13:08:07 INFO - 'NO_EM_RESTART': '1', 13:08:07 INFO - 'PAGER': '/bin/cat', 13:08:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:07 INFO - 'PWD': '/builds/slave/test', 13:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:07 INFO - 'SHELL': '/bin/bash', 13:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaANf9CNTq/Listeners', 13:08:07 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 13:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:07 INFO - 'USER': 'cltbld', 13:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:07 INFO - 'XPC_FLAGS': '0x0', 13:08:07 INFO - 'XPC_SERVICE_NAME': '0', 13:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:08:10 INFO - Installing collected packages: mozsystemmonitor 13:08:10 INFO - Running setup.py install for mozsystemmonitor 13:08:10 INFO - Successfully installed mozsystemmonitor 13:08:10 INFO - Cleaning up... 13:08:10 INFO - Return code: 0 13:08:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:08: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')]} 13:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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')]} 13:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e713b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e716768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7435a5340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f1d30>, '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 0x10e418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4e6be8>, '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.MwLbrVfNLC/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.jaANf9CNTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 13:08:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:08:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MwLbrVfNLC/Render', 13:08:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:10 INFO - 'HOME': '/Users/cltbld', 13:08:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:10 INFO - 'LOGNAME': 'cltbld', 13:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:10 INFO - 'MOZ_NO_REMOTE': '1', 13:08:10 INFO - 'NO_EM_RESTART': '1', 13:08:10 INFO - 'PAGER': '/bin/cat', 13:08:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:10 INFO - 'PWD': '/builds/slave/test', 13:08:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:10 INFO - 'SHELL': '/bin/bash', 13:08:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaANf9CNTq/Listeners', 13:08:10 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 13:08:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:10 INFO - 'USER': 'cltbld', 13:08:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:10 INFO - 'XPC_FLAGS': '0x0', 13:08:10 INFO - 'XPC_SERVICE_NAME': '0', 13:08:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:10 INFO - Downloading/unpacking jsonschema==2.5.1 13:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:08:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:13 INFO - Downloading functools32-3.2.3-2.tar.gz 13:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:08:13 INFO - warning: no files found matching '*.txt' 13:08:13 INFO - no previously-included directories found matching 'build' 13:08:13 INFO - no previously-included directories found matching 'dist' 13:08:13 INFO - no previously-included directories found matching '.git*' 13:08:13 INFO - Installing collected packages: jsonschema, functools32 13:08:13 INFO - Running setup.py install for functools32 13:08:13 INFO - warning: no files found matching '*.txt' 13:08:13 INFO - no previously-included directories found matching 'build' 13:08:13 INFO - no previously-included directories found matching 'dist' 13:08:13 INFO - no previously-included directories found matching '.git*' 13:08:13 INFO - Successfully installed jsonschema functools32 13:08:13 INFO - Cleaning up... 13:08:14 INFO - Return code: 0 13:08:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e713b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e716768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7435a5340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f1d30>, '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 0x10e418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4e6be8>, '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.MwLbrVfNLC/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.jaANf9CNTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 13:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:08:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MwLbrVfNLC/Render', 13:08:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:14 INFO - 'HOME': '/Users/cltbld', 13:08:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:14 INFO - 'LOGNAME': 'cltbld', 13:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:14 INFO - 'MOZ_NO_REMOTE': '1', 13:08:14 INFO - 'NO_EM_RESTART': '1', 13:08:14 INFO - 'PAGER': '/bin/cat', 13:08:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:14 INFO - 'PWD': '/builds/slave/test', 13:08:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:14 INFO - 'SHELL': '/bin/bash', 13:08:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaANf9CNTq/Listeners', 13:08:14 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 13:08:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:14 INFO - 'USER': 'cltbld', 13:08:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:14 INFO - 'XPC_FLAGS': '0x0', 13:08:14 INFO - 'XPC_SERVICE_NAME': '0', 13:08:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:08:14 INFO - Cleaning up... 13:08:14 INFO - Return code: 0 13:08:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e713b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e716768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7435a5340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f1d30>, '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 0x10e418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4e6be8>, '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.MwLbrVfNLC/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.jaANf9CNTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 13:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:08:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MwLbrVfNLC/Render', 13:08:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:14 INFO - 'HOME': '/Users/cltbld', 13:08:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:14 INFO - 'LOGNAME': 'cltbld', 13:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:14 INFO - 'MOZ_NO_REMOTE': '1', 13:08:14 INFO - 'NO_EM_RESTART': '1', 13:08:14 INFO - 'PAGER': '/bin/cat', 13:08:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:14 INFO - 'PWD': '/builds/slave/test', 13:08:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:14 INFO - 'SHELL': '/bin/bash', 13:08:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaANf9CNTq/Listeners', 13:08:14 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 13:08:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:14 INFO - 'USER': 'cltbld', 13:08:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:14 INFO - 'XPC_FLAGS': '0x0', 13:08:14 INFO - 'XPC_SERVICE_NAME': '0', 13:08:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:14 INFO - Downloading/unpacking blobuploader==1.2.4 13:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:17 INFO - Downloading blobuploader-1.2.4.tar.gz 13:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:08:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:08:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:18 INFO - Downloading docopt-0.6.1.tar.gz 13:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:08:18 INFO - Installing collected packages: blobuploader, requests, docopt 13:08:18 INFO - Running setup.py install for blobuploader 13:08:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:08:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:08:18 INFO - Running setup.py install for requests 13:08:19 INFO - Running setup.py install for docopt 13:08:19 INFO - Successfully installed blobuploader requests docopt 13:08:19 INFO - Cleaning up... 13:08:19 INFO - Return code: 0 13:08:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08: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')]} 13:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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')]} 13:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e713b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e716768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7435a5340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f1d30>, '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 0x10e418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4e6be8>, '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.MwLbrVfNLC/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.jaANf9CNTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 13:08:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:08:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MwLbrVfNLC/Render', 13:08:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:19 INFO - 'HOME': '/Users/cltbld', 13:08:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:19 INFO - 'LOGNAME': 'cltbld', 13:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:19 INFO - 'MOZ_NO_REMOTE': '1', 13:08:19 INFO - 'NO_EM_RESTART': '1', 13:08:19 INFO - 'PAGER': '/bin/cat', 13:08:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:19 INFO - 'PWD': '/builds/slave/test', 13:08:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:19 INFO - 'SHELL': '/bin/bash', 13:08:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaANf9CNTq/Listeners', 13:08:19 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 13:08:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:19 INFO - 'USER': 'cltbld', 13:08:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:19 INFO - 'XPC_FLAGS': '0x0', 13:08:19 INFO - 'XPC_SERVICE_NAME': '0', 13:08:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:19 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-FtHb96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:19 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-uXx5el-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:19 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-9zKIco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:19 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-sb4zK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-T6m0ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-97srgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-0NcieV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-TLoZAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-asSthz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-DgZ4Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-1iraGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-WFZqRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-brRXOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:21 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-i7McG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:21 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-3kpA2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:21 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-lMdQSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:21 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-pj4Vkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:08:21 INFO - Running setup.py install for manifestparser 13:08:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:08:21 INFO - Running setup.py install for mozcrash 13:08:21 INFO - Running setup.py install for mozdebug 13:08:21 INFO - Running setup.py install for mozdevice 13:08:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:08:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:08:22 INFO - Running setup.py install for mozfile 13:08:22 INFO - Running setup.py install for mozhttpd 13:08:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:08:22 INFO - Running setup.py install for mozinfo 13:08:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:08:22 INFO - Running setup.py install for mozInstall 13:08:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:08:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:08:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:08:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:08:22 INFO - Running setup.py install for mozleak 13:08:22 INFO - Running setup.py install for mozlog 13:08:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:08:22 INFO - Running setup.py install for moznetwork 13:08:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:08:23 INFO - Running setup.py install for mozprocess 13:08:23 INFO - Running setup.py install for mozprofile 13:08:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:08:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:08:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:08:23 INFO - Running setup.py install for mozrunner 13:08:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:08:23 INFO - Running setup.py install for mozscreenshot 13:08:23 INFO - Running setup.py install for moztest 13:08:23 INFO - Running setup.py install for mozversion 13:08:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:08:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:08:24 INFO - Cleaning up... 13:08:24 INFO - Return code: 0 13:08:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e713b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e716768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7435a5340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f1d30>, '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 0x10e418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4e6be8>, '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.MwLbrVfNLC/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.jaANf9CNTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 13:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:08:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MwLbrVfNLC/Render', 13:08:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:24 INFO - 'HOME': '/Users/cltbld', 13:08:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:24 INFO - 'LOGNAME': 'cltbld', 13:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:24 INFO - 'MOZ_NO_REMOTE': '1', 13:08:24 INFO - 'NO_EM_RESTART': '1', 13:08:24 INFO - 'PAGER': '/bin/cat', 13:08:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:24 INFO - 'PWD': '/builds/slave/test', 13:08:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:24 INFO - 'SHELL': '/bin/bash', 13:08:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaANf9CNTq/Listeners', 13:08:24 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 13:08:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:24 INFO - 'USER': 'cltbld', 13:08:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:24 INFO - 'XPC_FLAGS': '0x0', 13:08:24 INFO - 'XPC_SERVICE_NAME': '0', 13:08:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-HGJ2vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-lsGOnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Os6usz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-nRnv2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:24 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)) 13:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-mqQYQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:24 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)) 13:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-j2FIWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:24 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)) 13:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-teA0bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Tcd1Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-6IDpVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Ptenb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-fLuy8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-fII_Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:25 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)) 13:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-w6Wddq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:25 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)) 13:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-CzL_P3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:25 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)) 13:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-UgKHz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:25 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)) 13:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-QTbu1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:26 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-4fQNgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:08:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08:28 INFO - Downloading blessings-1.6.tar.gz 13:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:08:28 INFO - Installing collected packages: blessings 13:08:28 INFO - Running setup.py install for blessings 13:08:28 INFO - Successfully installed blessings 13:08:28 INFO - Cleaning up... 13:08:29 INFO - Return code: 0 13:08:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:08:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:29 INFO - Reading from file tmpfile_stdout 13:08:29 INFO - Current package versions: 13:08:29 INFO - blessings == 1.6 13:08:29 INFO - blobuploader == 1.2.4 13:08:29 INFO - docopt == 0.6.1 13:08:29 INFO - functools32 == 3.2.3-2 13:08:29 INFO - jsonschema == 2.5.1 13:08:29 INFO - manifestparser == 1.1 13:08:29 INFO - mozInstall == 1.12 13:08:29 INFO - mozcrash == 1.0 13:08:29 INFO - mozdebug == 0.1 13:08:29 INFO - mozdevice == 0.49 13:08:29 INFO - mozfile == 1.2 13:08:29 INFO - mozhttpd == 0.7 13:08:29 INFO - mozinfo == 0.9 13:08:29 INFO - mozleak == 0.1 13:08:29 INFO - mozlog == 3.4 13:08:29 INFO - moznetwork == 0.27 13:08:29 INFO - mozprocess == 0.24 13:08:29 INFO - mozprofile == 0.28 13:08:29 INFO - mozrunner == 6.13 13:08:29 INFO - mozscreenshot == 0.1 13:08:29 INFO - mozsystemmonitor == 0.3 13:08:29 INFO - moztest == 0.8 13:08:29 INFO - mozversion == 1.4 13:08:29 INFO - psutil == 3.1.1 13:08:29 INFO - requests == 1.2.3 13:08:29 INFO - wsgiref == 0.1.2 13:08:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e713b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e716768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7435a5340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f1d30>, '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 0x10e418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4e6be8>, '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.MwLbrVfNLC/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.jaANf9CNTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 13:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:08:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MwLbrVfNLC/Render', 13:08:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:29 INFO - 'HOME': '/Users/cltbld', 13:08:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:29 INFO - 'LOGNAME': 'cltbld', 13:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:29 INFO - 'MOZ_NO_REMOTE': '1', 13:08:29 INFO - 'NO_EM_RESTART': '1', 13:08:29 INFO - 'PAGER': '/bin/cat', 13:08:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:29 INFO - 'PWD': '/builds/slave/test', 13:08:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:29 INFO - 'SHELL': '/bin/bash', 13:08:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaANf9CNTq/Listeners', 13:08:29 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 13:08:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:29 INFO - 'USER': 'cltbld', 13:08:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:29 INFO - 'XPC_FLAGS': '0x0', 13:08:29 INFO - 'XPC_SERVICE_NAME': '0', 13:08:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:08:29 INFO - Cleaning up... 13:08:29 INFO - Return code: 0 13:08:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e713b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e716768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7435a5340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f1d30>, '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 0x10e418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4e6be8>, '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.MwLbrVfNLC/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.jaANf9CNTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 13:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:08:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MwLbrVfNLC/Render', 13:08:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:29 INFO - 'HOME': '/Users/cltbld', 13:08:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:29 INFO - 'LOGNAME': 'cltbld', 13:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:29 INFO - 'MOZ_NO_REMOTE': '1', 13:08:29 INFO - 'NO_EM_RESTART': '1', 13:08:29 INFO - 'PAGER': '/bin/cat', 13:08:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:29 INFO - 'PWD': '/builds/slave/test', 13:08:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:29 INFO - 'SHELL': '/bin/bash', 13:08:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaANf9CNTq/Listeners', 13:08:29 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 13:08:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:29 INFO - 'USER': 'cltbld', 13:08:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:29 INFO - 'XPC_FLAGS': '0x0', 13:08:29 INFO - 'XPC_SERVICE_NAME': '0', 13:08:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:08:29 INFO - Cleaning up... 13:08:29 INFO - Return code: 0 13:08:29 INFO - Running post-action listener: _resource_record_post_action 13:08:29 INFO - Running post-action listener: _start_resource_monitoring 13:08:29 INFO - Starting resource monitoring. 13:08:29 INFO - [mozharness: 2017-02-11 21:08:29.888325Z] Finished create-virtualenv step (success) 13:08:29 INFO - [mozharness: 2017-02-11 21:08:29.889352Z] Running install step. 13:08:29 INFO - Running pre-action listener: _resource_record_pre_action 13:08:29 INFO - Running main action method: install 13:08:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:30 INFO - Reading from file tmpfile_stdout 13:08:30 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:30 INFO - Reading from file tmpfile_stdout 13:08:30 INFO - Output received: 13:08:30 INFO - Usage: mozinstall [options] installer 13:08:30 INFO - Options: 13:08:30 INFO - -h, --help show this help message and exit 13:08:30 INFO - -d DEST, --destination=DEST 13:08:30 INFO - Directory to install application into. [default: 13:08:30 INFO - "/builds/slave/test"] 13:08:30 INFO - --app=APP Application being installed. [default: firefox] 13:08:30 INFO - mkdir: /builds/slave/test/build/application 13:08:30 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'] 13:08:30 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 13:08:50 INFO - Reading from file tmpfile_stdout 13:08:50 INFO - Output received: 13:08:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:08:50 INFO - Running post-action listener: _resource_record_post_action 13:08:50 INFO - [mozharness: 2017-02-11 21:08:50.063843Z] Finished install step (success) 13:08:50 INFO - [mozharness: 2017-02-11 21:08:50.063980Z] Running run-tests step. 13:08:50 INFO - Running pre-action listener: _resource_record_pre_action 13:08:50 INFO - Running main action method: run_tests 13:08:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:08:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:08:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:08:50 INFO - 2017-02-11 13:08:50.078 screenresolution[1641:10230] starting screenresolution argv=screenresolution get 13:08:50 INFO - 2017-02-11 13:08:50.080 screenresolution[1641:10230] Display 0: 1600x1200x32@60 13:08:50 INFO - 2017-02-11 13:08:50.086 screenresolution[1642:10233] starting screenresolution argv=screenresolution list 13:08:50 INFO - Available Modes on Display 0 13:08:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:08:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:08:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:08:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:08:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:08:50 INFO - Intel Iris: 13:08:50 INFO - Chipset Model: Intel Iris 13:08:50 INFO - Type: GPU 13:08:50 INFO - Bus: Built-In 13:08:50 INFO - VRAM (Dynamic, Max): 1536 MB 13:08:50 INFO - Vendor: Intel (0x8086) 13:08:50 INFO - Device ID: 0x0a2e 13:08:50 INFO - Revision ID: 0x0009 13:08:50 INFO - Displays: 13:08:50 INFO - Display: 13:08:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:08:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:08:50 INFO - Display Serial Number: 1600x1200 60 13:08:50 INFO - Main Display: Yes 13:08:50 INFO - Mirror: Off 13:08:50 INFO - Online: Yes 13:08:50 INFO - Rotation: Supported 13:08:50 INFO - Return code: 0 13:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:08:50 INFO - Python 2.7.3 13:08:50 INFO - Return code: 0 13:08:50 INFO - grabbing minidump binary from tooltool 13:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4f1d30>, '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 0x10e418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e4e6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:08:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:08:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:08:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:08:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:08:50 INFO - Return code: 0 13:08:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:08:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:08:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:08:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:08:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:08:50 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/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0369', '--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 13:08:50 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/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0369 --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 13:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MwLbrVfNLC/Render', 13:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:50 INFO - 'HOME': '/Users/cltbld', 13:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:50 INFO - 'LOGNAME': 'cltbld', 13:08:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:08:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:50 INFO - 'MOZ_NO_REMOTE': '1', 13:08:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:08:50 INFO - 'NO_EM_RESTART': '1', 13:08:50 INFO - 'PAGER': '/bin/cat', 13:08:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:50 INFO - 'PWD': '/builds/slave/test', 13:08:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:50 INFO - 'SHELL': '/bin/bash', 13:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaANf9CNTq/Listeners', 13:08:50 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 13:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:50 INFO - 'USER': 'cltbld', 13:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:50 INFO - 'XPC_FLAGS': '0x0', 13:08:50 INFO - 'XPC_SERVICE_NAME': '0', 13:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:50 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/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0369', '--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 13:08:50 INFO - mozversion application_buildid: 20170211070119 13:08:50 INFO - mozversion application_changeset: 8a64bfa2d3564c97bb67710f479a0fc4ccc4a08b 13:08:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:08:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:08:50 INFO - mozversion application_name: Firefox 13:08:50 INFO - mozversion application_remotingname: firefox-dev 13:08:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:08:50 INFO - mozversion application_vendor: Mozilla 13:08:50 INFO - mozversion application_version: 53.0a2 13:08:50 INFO - mozversion platform_buildid: 20170211070119 13:08:50 INFO - mozversion platform_changeset: 8a64bfa2d3564c97bb67710f479a0fc4ccc4a08b 13:08:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:08:50 INFO - mozversion platform_version: 53.0a2 13:08:50 INFO - using testdate: 1486847330 13:08:50 INFO - actual date: 1486847330 13:08:50 INFO - starting webserver on 'localhost:49259' 13:08:50 INFO - SUITE-START | Running 2 tests 13:08:50 INFO - TEST-START | dromaeo_css 13:08:50 INFO - operating with platform_type : mac_ 13:08:50 INFO - Initialising browser for dromaeo_css test... 13:08:50 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmp45G2hD/profile http://localhost:49259/getInfo.html) 13:08:53 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 13:08:53 INFO - PROCESS | 1652 | colorDepth:24 13:08:53 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 13:08:53 INFO - PROCESS | 1652 | __metrics 13:08:53 INFO - PROCESS | 1652 | 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" 13:08:53 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:08:54 INFO - TEST-INFO | 1652: exit 0 13:08:54 INFO - Browser initialized. 13:08:54 INFO - Running cycle 1/1 for dromaeo_css test... 13:08:54 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmp45G2hD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:06 INFO - PROCESS | 1655 | RSS: Main: 213405696 13:09:06 INFO - PROCESS | 1655 | 13:12:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49259/tests/dromaeo/cssquery-ext.html) 13:12:11 INFO - PROCESS | 1655 | RSS: Main: 388755456 13:12:11 INFO - PROCESS | 1655 | 13:13:55 INFO - PROCESS | 1655 | ************************* 13:13:55 INFO - PROCESS | 1655 | A coding exception was thrown and uncaught in a Task. 13:13:55 INFO - PROCESS | 1655 | 13:13:55 ERROR - PROCESS | 1655 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:13:55 INFO - PROCESS | 1655 | Full stack: 13:13:55 INFO - PROCESS | 1655 | ************************* 13:15:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-ext.html (next: http://localhost:49259/tests/dromaeo/cssquery-jquery.html) 13:15:15 INFO - PROCESS | 1655 | RSS: Main: 348913664 13:15:15 INFO - PROCESS | 1655 | 13:18:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49259/tests/dromaeo/cssquery-mootools.html) 13:18:18 INFO - PROCESS | 1655 | RSS: Main: 325672960 13:18:18 INFO - PROCESS | 1655 | 13:21:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49259/tests/dromaeo/cssquery-prototype.html) 13:21:21 INFO - PROCESS | 1655 | RSS: Main: 329134080 13:21:21 INFO - PROCESS | 1655 | 13:24:24 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49259/tests/dromaeo/cssquery-yui.html) 13:24:25 INFO - PROCESS | 1655 | RSS: Main: 317022208 13:24:25 INFO - PROCESS | 1655 | 13:27:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-yui.html (next: http://localhost:49259/tests/dromaeo/cssquery-dojo.html) 13:27:28 INFO - PROCESS | 1655 | RSS: Main: 487956480 13:27:28 INFO - PROCESS | 1655 | 13:27:28 INFO - PROCESS | 1655 | __start_tp_report 13:27:28 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 13:27:28 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 13:27:28 INFO - PROCESS | 1655 | |i|pagename|runs| 13:27:28 INFO - PROCESS | 1655 | |0;dojo.html;3316.336732653469;3338.148772063125;3343.364760695468;3351.7988920664775;3397.3375191837586;5676.687782171984;5697.173909783079;5702;5718.914216286754;5719.999000174974;4565.2467342888385;4685.344051832746;5608.46719561642;5686.402927692595;5705.972924873521;5158.277841102239;5201.453847346031;5202.401723801773;5291.126964050927;5345.786168553253;5162.096633089213;5163.173892177252;5166.535011848933;5221.269022336875;5299.470052994709;5219.42586315505;5232.16285394337;5237.083510385667;5261.316028916254;5292.523672869441;5261.552768014723;5287.9424115176735;5296.788128474856;5296.814611488579;5298.284731561228;5094.6688465249645;5206.088934436459;5228.9477105229225;5232.659877107976;5251.369835619712;5551.889622075601;5594.272744543224;5597.608167428281;5620.903923734873;5710.543156547507;6207.286162091372;6293;6295.024271237966;6309.432151106423;6312.779052733178;6233.2208473940755;6340.809775706736;6342;6350.174477317965;6351.841203969938;5673.744681489343;5716.314042314949;5825.0971099480075;5904.97047514764;5911.527077833763;5107.259447380109;6165.475934545524;6331.68341582919;6343.5876668016435;6349.936500635027;6147.631142131487;6153.8461538461;6154.5384096192065;6157.815265542041;6162.7843025494785;6199.504039676815;6263.498920086382;6266.780662676875;6276.968615156895;6279.560430769893;5049.646524743306;6020.909686354708;6075.513958883279;6083.300420451705;6090.939090609126;6126.724297406628;6177.876442471125;6193.411625895533;6201.193844800147;6206.875862482725;4219.346001369792;4927.310176575283;4930.7288099154175;4939.333190019373;4977;4326.156399502067;4406.383106365111;4413.492448368414;4420.160169567836;4447.355133505688;5807.157962095557;5821.679807610537;5823.5341172706085;5846.356900740915;5857.355690874;6116.113163591343;6143.72682107623;6289.371062893765;6309.716062777186;6323.241211054703;5664.773409063591;5723.399043100498;5754.1944127822135;5778.8266352009505;5848.444397782204;5468.91796623051;5472.343318801769;5473.2063850742215;5476.644018138808;5482;6285.340039295991;6347.650879201688;6384.4254017137755;6386.16979792624;6386.265579458422;6137.140800288053;6195.721192546256;6229.750809967732;6269.279032911091;6278.811635650755;6342.080398342122;6352.523560733056;6369.9681501592195;6380.840478987877;6423.582467139621;6264.749410023548;6266.655333956493;6287.779927702509;6295.087212354091;6314.273858506331;5938.554608404301;6146.354632763674;6148.231471066117;6334.429901308904;6339.96830015847;6025.8192254232445;6133.662648554372;6137.938620613737;6168.599041062316;6179.949408600459;6055.852525353414;6139.386061393825;6154.076888466587;6156.29202641702;6158.907616385847;5809.883802323845;5936.22829032223;5968.569659937202;5986.880262394815;5996.070609055603;5959.314678811992;6049.153118563317;6062.878742425215;6103.176071230327;6128.295246046761;5970.910436343372;5972.25346831646;5984.281886173687;5989.011813050972;5997 13:27:28 INFO - PROCESS | 1655 | |1;ext.html;443.23099422501974;459.5657104036687;470.2663844402731;490.5633985752681;501.95733362664197;31345.216369590773;33233.51048139944;33260.5010924836;33268.667313326856;33337.83331083341;42084.78957605208;44073.338899916525;44081.779591102;46346.07307853841;46513.534864651345;9344.81310373792;9504.667336643219;9538.141567258945;9544.379615325017;9555.761105972337;8481.279091277249;9381.437113773161;9495.715128546155;9496.335256532011;9570.186534144606;8483.321334293272;11253.099752019818;11494;11533.365664888428;11710.121740869427;11360.920712532296;11394.031507321888;11460.885391146065;11501.252418592765;11520.654380368518;8477.321814254907;8688.174623410765;11378.089752819755;11455.140864435201;11488.540458381654;42658.78670606658;43318;43358.566414336085;43519;43576.3463548047;3977.642012218885;3981;3988.641022308006;4004.599540046001;4004.8598299059686;29378.853105734335;29904.40191196164;31053.534196987064;31773.682263177536;31993.84003079993;3255.869765209389;3260.8532616032335;3325.900222993314;3367.7979321240805;3372.426687463137;483216;488154;489085;490491;490851;63328.366716332246;63630.36369636337;65594;65843;66058.33941660618;63477;63585.68207158935;63769;63817.68091159515;63830.36169638337;16893.662126757397;17095.829041709672;17100.74348884768;17102.315907363565;17110.88779229371;13091.803622945663;13215.537456188988;13226.404811783494;13237.867621323663;13238.933805330911;12534.310612916195;16032.118233497036;16071.35714571404;16705.6658866822;18189.81810181881;6543.411093001652;6734.292899245606;6799.524033317621;6869.175698916162;6917.7232910684015;861;863.7926897544544;893.5442924108621;893.9687110951086;913.7669894176943;25890.611640825402;30625.387492250476;30851.920182793496;30980;31346.686533134834;936.0686117313317;944.91932528402;980.4215512847312;1118.692359601116;1174.0255587862055;14492.492762753252;14886.957912945989;14902.850971490363;15203.543893682985;15224.477552244687;421222;423987;425464;425731;426001;57840;58003;58062.7096864513;58100;58313.70843145757;1428.1431141315336;1439.5537383411177;1472.683373074794;1473.4474572035272;1478.342137748713;22544;27419.177424676494;28002.439951201268;28729;29265.707342926296;48630.83899546518;48712.025759483906;49019.0196196067;49052.75473622609;49079;365544;368544;368733;369290.15354923054;369614;37456.625433745314;38687;38750;38820;38951.80524097361;30711.692883070882;33330.66669333276;40700;43569.78215108904;44609.330860036476;36314.8184259077;36482.452763209105;36794.81602592077;36840.81579592085;37141.81429092837;34290.48564271588;35118.12204694903;35938.406159383856;37729.245415091;38015.61984380231;35638.93083207508;36300.27399452049;36322.8183859079;36531.634683652825;36757.89726308215;30938.0718578443;32807.83596082004;32870.835645821615;32943;33034.83482582572;24404;24902.626460602743;25297.448305105296;25429.872850635627;25658.87170564135 13:27:28 INFO - PROCESS | 1655 | |2;jquery.html;354.8669249031613;374.21788462114176;396.4489359789891;405.4303703296867;426.14557811587764;14994.40022399104;15384.769228461568;17560.912195439036;20248.39254822354;20392.395954103857;20835.687464688042;20997.580048399024;21160.94195290237;21225.57548849022;21856.235031773893;5782.24830771999;5805.24531810865;6003.219581454427;6061.515078793686;6068.969655151718;4225.957740422603;5889.8822023559505;5977.013792724195;5984.401559844025;5994.040953447449;4402.559744025604;5632.239647647577;6373.490120790326;6714.764983225588;6767.627780472072;6223.3776622337855;6532.6407047612365;6732.865342693168;6767.458603311723;6804.761833335834;5719.857003574903;5806.912896306559;5856.7071646417935;5871.324797648283;5893.79371721992;24228.39429014271;25205.87397063003;26042.21873343803;26385.73614263852;26700.332491687863;2528.2541650213047;2565.422779874532;2610.099515667092;2621.9606705899428;2627.5401804684293;10075.294729368874;10528.526216320208;10565.101966332872;12630.30533320667;15933.442329518411;1829.4328758085037;1829.634073185355;1837.61410103877;1838.4208974173093;1851.1577232359243;81276;133480;138017;139657;140311.99999999898;11763.058955283557;11793.52825886955;11964.64106076819;12024.398780060961;12054.15620906528;12881.420336084899;15624.76562851558;15678.529644110695;15685.607859803597;15703.764443533357;8656.307495400353;8903.599338029804;8980.281577473786;9031.096890310917;9042.819143617222;7227.602481863443;8387.62255698495;8737.344699147588;8764;8915.821683566292;4686.414198225222;4762.261849413278;4771.23660214364;4846.466888642247;4852.320675105488;1839.7516335294563;1980.2969945669367;2029.5129168999333;2037.4006404972322;2044.8159665630164;977.7018009507169;989.9703008909744;993.6025589764153;996.7308826616772;1029.552144817007;20622.896885515478;21325.786742132692;22010.669839952414;23661.645075323882;23918.760812392;790.6916302641974;822.6668199379261;935.2985261054209;935.934484586086;943.5895385507326;6974.755883544051;7041.295870412918;7044.964775176091;7050.717971281194;7077.716891324392;708835;759220;789721;796127.0193648995;797243;142178;145248;146398.53601464062;146403;152244;1062.6652604429735;1074.1514203778927;1082.718493191776;1102.1238115698038;1110.3670907582762;12468.875311246771;12592.622221333375;12634.557790477289;12771.61685149447;12808;59881.203563893156;60563.69718151381;60915.69542152261;61285;62828.46058473013;67173.99239011321;83769;97440.01188619142;99051;101722.49138754555;8394.790130246549;8485.660573577235;8595;8712.085231050902;8746.344024198082;10674.946625266824;11732.70668233301;11963.461644225858;13695.452181912611;13797.586072417844;11258.493367798304;11302.152338574475;11554.248973816675;11838.28970261787;11850.170488065753;10030.348027378197;11377.772444551229;11403;11570.537178513101;12003.459844307201;10898.18263630215;11542.076633869438;11908.642740717793;11919.463624137108;12073.517059317881;7064.576125432491;7587.051618547682;7738.574378409242;7918.564478953483;8844.601992910462;9271.582778774837;9808.705738827846;9873.901260987299;11597.942010289895;11722.58970936013 13:27:28 INFO - PROCESS | 1655 | |3;mootools.html;1256.246252248651;1452.6295794572382;1453.2733633183416;1462.4077248714275;1465.6922046370262;8141.633626486808;8371.455855369397;8553.40126191167;8598.527081010541;8601.91398086019;7539.811504712385;7740.922590774105;7747.418943579226;8157.796055098625;8355.164483551642;2176.325339144866;2223.1663126327626;2224.4550085229143;2226.9665955010687;2227.7772222777676;2263.649134384173;2356.4815740537056;2374.157174203159;2377.821663375245;2380.75002124777;2071.2957594417894;2146.452654573082;2273.7271527416733;2334.953300933989;2354.6468029795583;2332.5568142052957;2337.1819863047967;2339.2163625185585;2340.660604212388;2344.308429013428;2282.805961493275;2352.447174913894;2358.2689366296504;2358.870262135582;2360.586897292967;8439.198276163756;8505;8519.36104792137;8520.275776559;8520.829583408358;5117.232415137759;5260.473952604747;5268.736563171826;5277.86805329866;5282.709450980195;3253.3655937092276;3310.536524886518;3376.5272861799367;3407.795532268072;3413.112590726404;1168.976620467586;1172.994135029328;1215.671768622467;1215.817627355895;1217.6955761059735;10774.999999999922;10892.509837057352;11016.008559229627;11020.614278500214;11025.228234023622;4503.1086943483815;4683.461401938753;4754.096721622881;4755.690880092783;4763.642726795504;9535.761605959906;9542.33203675736;9543.33196676226;9544.522773861418;9563.282753793494;5275.920861187085;5286.154215325606;5286.81496147633;5287.101192797234;5298.91372268684;4700.623950083985;4706.788194531255;4799.760011999386;4857.8299759508245;4882.096812089775;3848.7113466490127;3908.3160446921675;3950.249452603996;3957.683385329167;3958.6635136013188;1163.5229555882047;1214.5668111628188;1296.1574976265315;1303.2115570080155;1308.9149205301626;636.4908073541241;769.1731388757108;778.7741554949115;784.7841843493085;793.0879488588055;5435.809746658927;5467.152591348347;5480.232767412565;5569.777208911679;5801.82594522165;1003.7641154328727;1011.1001208924064;1016.1261315268863;1025.8409946458162;1036.8341065429645;3665.3585622515952;3823.6941044716355;3848.3265428549894;3864.845406183721;3871.05159235989;8503.447275927168;10049.346792458467;10064.69805905824;10206.23453240995;10215.693529194135;9995.650152244636;10064.39613623185;10154.238432117472;10160.644377446753;10162.593496260066;7735.303822655988;7830.804229894298;8011.1588283230585;8029.678812847537;8034.397420193392;5407.215953686772;5449.836504904859;5514.172874068921;5549.5837812165055;5593.049181639212;9228.492432916253;9259.98618654119;9357.877054753473;9401.247900168108;9514;9501.952490237505;9543.0456954304;9558.139767420966;9630.518474076409;9682.612695492102;6721.059051732664;6800.217974932748;6800.829979250559;6880.002399652122;6910;7784.455088144002;7801.765947021599;7902.565358905315;7906.446548741533;7913.089994650459;7040.084788977605;7121.074260346122;7150.499465037606;7178.533395329287;7319.121705395387;6959.965200173967;7018.912068629371;7023.192332881784;7045.365917067488;7073.6816843243205;6375.043743438521;6386.616802991835;6419.903701444388;6479.092926990131;6479.287278399278;4964.180910149785;4979.477154898828;5004.524570165829;5056.721880296619;5101.260317253903;4938.061768264019;4994.9750251248515;4998.3002379667605;5115.823360627002;5120.590352771844 13:27:28 INFO - PROCESS | 1655 | |4;prototype.html;354.6329548916871;362.7279540344741;365.72570572070947;374.47760374277885;375.97932113733737;4592.908141837165;4718.740469274188;4951.727654978975;5154.252633368159;5191.5846732261425;4464.218761716695;4969.5030496950285;5069.923951140736;5071.478556433074;5168.2764412982215;4077.3068578341604;4078.959865234361;4081.2245673322122;4088.672906167514;4095.4061661059127;3748.3253014457387;4097.836086556535;4102.5692302308125;4109.404136400235;4139.441175441322;3333.666633336671;3927.3519869221545;3936.3898595717565;3950.1902110067367;3972.682185425159;3925.3523168677134;3942.7240093193486;3942.974826545119;3943.4084887266854;3955.5648878623474;3161.7786754927165;3438.9828050859587;3444.2078321986082;3468.3063387322386;3479.5128681984543;4709.764511774431;4952.430470495903;5060.508249307965;5097.898042039175;5105.243168688903;3749.8312575933874;4462.085272519126;4484.632187182908;4485.183500682197;4490;5227.26818245446;5407.972960135174;5465.07093794056;5501.14732216507;5532.197831314477;3555.8044307563073;3691.6492933171576;3759.5300587426573;3760.8307626156616;3819.656230939229;4487.798049087799;5636.323641163087;5655.945789273787;5702.116171993348;5729.965862118929;3228.467302894996;3569.8929032129076;3835.520559930009;3841.8271177797064;3843.6925045996254;3290.605127384681;3873.96126038736;3875.399313106473;3891.69628174559;3910.902227444337;3911.0720492180058;4222.9577704223175;4285.3786201000685;4461.754603496774;4517.5256598057385;4811.604634655981;4960.032793605213;5514.696691681996;5530.446955304518;5532.28080349552;1205.806251810701;1215.750771091924;1230.0467137967967;1235.3884827010509;1258.9990957189057;706.8338940349014;856.7643897928119;863.7883718489011;868.6091258933506;874.7244617945327;4274.935875961863;4457.977710111429;4520.751358675238;4836.960053588496;5002.549260714352;5133.897322053538;5242.344706911636;5394.217838413408;5475.315585551806;5507.5593952483705;4364.512228029992;4798.5441383068555;5236.381809095452;5241.554467870274;5273.920891186635;2435.476372579904;2836.213185693;2842.545192769147;2854.8572571371346;2863.7852161088003;5424.349078110652;5548.500634942875;5647.265855438849;5661.264035675335;5671.6597004179885;4819.469858315582;5195.428502864682;5483.095289277305;5510.228568000483;5596.4403559644525;5287.990563585813;5402;5619.100943848965;5645.520130788929;5656.32124145097;5171.3277273954145;5407.215953686772;5673.723412232214;5708.628939118944;5732.426757324234;4393.494748103881;4895.4859739728245;5036.320096787033;5482.835514934558;5676.744546495335;5560.527355174855;5911.310353789102;5917.650526862839;5924.8815023700145;5924.941415130649;3345.4312766830185;3424.0482924732664;3746.2882052409955;3768;3894.3379625464304;5698.886022279448;5702.346319567279;5709.115087161496;5712.600117991867;5724.427557244242;5129.9743501282255;5409.756560954846;5501.724913754377;5534.39121696605;5627.662340259598;5480.451590010664;5490.066688663017;5498.890022199614;5513.786966867283;5536.335639723259;4372.934405983977;4817.9518204817505;5014.222795466709;5188.507091826271;5352.384475785178;5498.80754173602;5501.752421140978;5503.2114562766465;5506.972465137809;5526.447355264602;4662.836800711959;5200.323957885451;5366.812161574326;5384.065684202197;5414.563446449035 13:27:28 INFO - PROCESS | 1655 | |5;yui.html;693.5699866083029;701.7158050989348;727.6434547071937;733.0836454431957;738.5421038955847;14754.852451475483;15539.611509712262;15562.610934726637;15633;15756.212189390528;14221.288935553233;14385.712285754278;14416.207108609022;15174.772378414333;16040.518784436486;762.5729591428803;784.2001158818002;784.9921500784976;786.7679034684782;787.7439832054577;776.5418403142145;778.2140038561066;779.4777499075633;779.5439667794319;780.0600276666603;802.5265093594778;819.9139090395512;822.3298012120104;823.217942954193;823.9752807415787;812.8211793405442;814.6049166154411;814.6782021101632;815.7389635316702;817.5340056167987;608.242737791448;608.5648761135809;608.7078202462843;608.7473698415153;610.0665981049002;15333;15672.764908526382;15707.136107514083;15718.449854255161;15721.764173537405;13745.862541374558;13794.93102534481;13815.378307976165;13818.447262109503;13900.652483687887;11161.218714689974;11462.254953428;11536.365499897502;11687.181897267195;11897.28616283017;3592.8203589820405;3625.1843335249623;3698.815059247027;3822.7132965027454;3835.137094153821;117360;117584.41207793992;117749;118377.8162218384;119771;10928.289661172157;11040.116790656728;11085.22403431752;11086.33481991067;11374.431278436045;22292.21977230789;22502.437439064153;22573;22688.432789180402;22927.19754808607;7811.843763124819;7836.412269079842;7858.1356050834365;7993.080795708452;8064.274215320649;4269.146170765859;4295.699301048959;4300.444170326657;4474.619657329098;4478.552144785495;3603.765755225902;3621.6016238213774;3678.834452449646;3703.203811180609;3712.870049548253;666.6699983508098;677.2144312597363;680.4488364424832;680.9182898052167;688.421725750372;651.5862427358661;666.1872515531045;685.8525417035262;706.7420391557148;713.4470785141453;9217.815643687089;10162.82514254006;10866.348019118877;11341.546338146381;11750.94124529372;553.8144721518256;580.9099589563624;588.632104934416;603.8852618002566;715.6743681624848;4840.95159048405;5013.874653133628;5029.547340739351;5040.57155141817;5052.34319538465;100699.49650251702;101595.9202039895;101803.49098254461;102055.97944020465;103211.45182822263;61020.0336978095;62844;75940.62029689817;80511;81488.77766833502;81522;81598;83598.16401836026;83636.58181709053;84364;10711.571537138427;11035.503402346752;11161.88838111641;11204.215704900906;11302.265352752045;47853;48829.2675609859;50068.998620026665;52102;53508.464915351906;30598.694013059583;30766.384672306875;34126.82936585301;56394.59013524531;58403.4159658398;12716.337424198056;12722.491100355883;12741.426635801596;13184.670383240496;13753.518626848012;13999.44002239899;14185.858141418454;14249.857501425267;14336.56990290293;14539.127652340894;10500.317479363817;13807;13946.930265348608;14141.363638636492;14797.260136992893;13535.390907408993;13562.864371356554;14067.929660351632;14082.436702531784;14521.636959076108;13307;13316.400761965928;13645.727085458433;13692.931535342259;14312.141271523742;11137.83293250618;11331.546738130382;11580.536778528765;11707.180497365103;11785.233959792586;9198.586063627019;11018.39398833072;11242.66272011841;11252.26860254081;11256.493457794255 13:27:28 INFO - PROCESS | 1655 | __end_tp_report 13:27:28 INFO - PROCESS | 1655 | __start_cc_report 13:27:28 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1879 13:27:28 INFO - PROCESS | 1655 | __end_cc_report 13:27:28 INFO - PROCESS | 1655 | __startTimestamp1486848448208__endTimestamp 13:27:28 INFO - PROCESS | 1655 | 13:27:28 INFO - PROCESS | 1655 | ------- Summary: start ------- 13:27:28 INFO - PROCESS | 1655 | Number of tests: 6 13:27:28 INFO - PROCESS | 1655 | 13:27:28 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5733.15 Median:5970.91 stddev:664.43 (11.1%) stddev-sans-first:638.85 13:27:28 INFO - PROCESS | 1655 | Values: 3316.3 3338.1 3343.4 3351.8 3397.3 5676.7 5697.2 5702.0 5718.9 5720.0 4565.2 4685.3 5608.5 5686.4 5706.0 5158.3 5201.5 5202.4 5291.1 5345.8 5162.1 5163.2 5166.5 5221.3 5299.5 5219.4 5232.2 5237.1 5261.3 5292.5 5261.6 5287.9 5296.8 5296.8 5298.3 5094.7 5206.1 5228.9 5232.7 5251.4 5551.9 5594.3 5597.6 5620.9 5710.5 6207.3 6293.0 6295.0 6309.4 6312.8 6233.2 6340.8 6342.0 6350.2 6351.8 5673.7 5716.3 5825.1 5905.0 5911.5 5107.3 6165.5 6331.7 6343.6 6349.9 6147.6 6153.8 6154.5 6157.8 6162.8 6199.5 6263.5 6266.8 6277.0 6279.6 5049.6 6020.9 6075.5 6083.3 6090.9 6126.7 6177.9 6193.4 6201.2 6206.9 4219.3 4927.3 4930.7 4939.3 4977.0 4326.2 4406.4 4413.5 4420.2 4447.4 5807.2 5821.7 5823.5 5846.4 5857.4 6116.1 6143.7 6289.4 6309.7 6323.2 5664.8 5723.4 5754.2 5778.8 5848.4 5468.9 5472.3 5473.2 5476.6 5482.0 6285.3 6347.7 6384.4 6386.2 6386.3 6137.1 6195.7 6229.8 6269.3 6278.8 6342.1 6352.5 6370.0 6380.8 6423.6 6264.7 6266.7 6287.8 6295.1 6314.3 5938.6 6146.4 6148.2 6334.4 6340.0 6025.8 6133.7 6137.9 6168.6 6179.9 6055.9 6139.4 6154.1 6156.3 6158.9 5809.9 5936.2 5968.6 5986.9 5996.1 5959.3 6049.2 6062.9 6103.2 6128.3 5970.9 5972.3 5984.3 5989.0 5997.0 13:27:28 INFO - PROCESS | 1655 | 13:27:28 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:58332.29 Median:369011.58 stddev:113807.43 (30.8%) stddev-sans-first:114043.69 13:27:28 INFO - PROCESS | 1655 | Values: 443.2 459.6 470.3 490.6 502.0 31345.2 33233.5 33260.5 33268.7 33337.8 42084.8 44073.3 44081.8 46346.1 46513.5 9344.8 9504.7 9538.1 9544.4 9555.8 8481.3 9381.4 9495.7 9496.3 9570.2 8483.3 11253.1 11494.0 11533.4 11710.1 11360.9 11394.0 11460.9 11501.3 11520.7 8477.3 8688.2 11378.1 11455.1 11488.5 42658.8 43318.0 43358.6 43519.0 43576.3 3977.6 3981.0 3988.6 4004.6 4004.9 29378.9 29904.4 31053.5 31773.7 31993.8 3255.9 3260.9 3325.9 3367.8 3372.4 483216.0 488154.0 489085.0 490491.0 490851.0 63328.4 63630.4 65594.0 65843.0 66058.3 63477.0 63585.7 63769.0 63817.7 63830.4 16893.7 17095.8 17100.7 17102.3 17110.9 13091.8 13215.5 13226.4 13237.9 13238.9 12534.3 16032.1 16071.4 16705.7 18189.8 6543.4 6734.3 6799.5 6869.2 6917.7 861.0 863.8 893.5 894.0 913.8 25890.6 30625.4 30851.9 30980.0 31346.7 936.1 944.9 980.4 1118.7 1174.0 14492.5 14887.0 14902.9 15203.5 15224.5 421222.0 423987.0 425464.0 425731.0 426001.0 57840.0 58003.0 58062.7 58100.0 58313.7 1428.1 1439.6 1472.7 1473.4 1478.3 22544.0 27419.2 28002.4 28729.0 29265.7 48630.8 48712.0 49019.0 49052.8 49079.0 365544.0 368544.0 368733.0 369290.2 369614.0 37456.6 38687.0 38750.0 38820.0 38951.8 30711.7 33330.7 40700.0 43569.8 44609.3 36314.8 36482.5 36794.8 36840.8 37141.8 34290.5 35118.1 35938.4 37729.2 38015.6 35638.9 36300.3 36322.8 36531.6 36757.9 30938.1 32807.8 32870.8 32943.0 33034.8 24404.0 24902.6 25297.4 25429.9 25658.9 13:27:28 INFO - PROCESS | 1655 | 13:27:28 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:40984.51 Median:14506.64 stddev:128127.98 (883.2%) stddev-sans-first:128451.09 13:27:28 INFO - PROCESS | 1655 | Values: 354.9 374.2 396.4 405.4 426.1 14994.4 15384.8 17560.9 20248.4 20392.4 20835.7 20997.6 21160.9 21225.6 21856.2 5782.2 5805.2 6003.2 6061.5 6069.0 4226.0 5889.9 5977.0 5984.4 5994.0 4402.6 5632.2 6373.5 6714.8 6767.6 6223.4 6532.6 6732.9 6767.5 6804.8 5719.9 5806.9 5856.7 5871.3 5893.8 24228.4 25205.9 26042.2 26385.7 26700.3 2528.3 2565.4 2610.1 2622.0 2627.5 10075.3 10528.5 10565.1 12630.3 15933.4 1829.4 1829.6 1837.6 1838.4 1851.2 81276.0 133480.0 138017.0 139657.0 140312.0 11763.1 11793.5 11964.6 12024.4 12054.2 12881.4 15624.8 15678.5 15685.6 15703.8 8656.3 8903.6 8980.3 9031.1 9042.8 7227.6 8387.6 8737.3 8764.0 8915.8 4686.4 4762.3 4771.2 4846.5 4852.3 1839.8 1980.3 2029.5 2037.4 2044.8 977.7 990.0 993.6 996.7 1029.6 20622.9 21325.8 22010.7 23661.6 23918.8 790.7 822.7 935.3 935.9 943.6 6974.8 7041.3 7045.0 7050.7 7077.7 708835.0 759220.0 789721.0 796127.0 797243.0 142178.0 145248.0 146398.5 146403.0 152244.0 1062.7 1074.2 1082.7 1102.1 1110.4 12468.9 12592.6 12634.6 12771.6 12808.0 59881.2 60563.7 60915.7 61285.0 62828.5 67174.0 83769.0 97440.0 99051.0 101722.5 8394.8 8485.7 8595.0 8712.1 8746.3 10674.9 11732.7 11963.5 13695.5 13797.6 11258.5 11302.2 11554.2 11838.3 11850.2 10030.3 11377.8 11403.0 11570.5 12003.5 10898.2 11542.1 11908.6 11919.5 12073.5 7064.6 7587.1 7738.6 7918.6 8844.6 9271.6 9808.7 9873.9 11597.9 11722.6 13:27:28 INFO - PROCESS | 1655 | 13:27:28 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5465.84 Median:5108.54 stddev:2987.17 (58.5%) stddev-sans-first:2978.80 13:27:28 INFO - PROCESS | 1655 | Values: 1256.2 1452.6 1453.3 1462.4 1465.7 8141.6 8371.5 8553.4 8598.5 8601.9 7539.8 7740.9 7747.4 8157.8 8355.2 2176.3 2223.2 2224.5 2227.0 2227.8 2263.6 2356.5 2374.2 2377.8 2380.8 2071.3 2146.5 2273.7 2335.0 2354.6 2332.6 2337.2 2339.2 2340.7 2344.3 2282.8 2352.4 2358.3 2358.9 2360.6 8439.2 8505.0 8519.4 8520.3 8520.8 5117.2 5260.5 5268.7 5277.9 5282.7 3253.4 3310.5 3376.5 3407.8 3413.1 1169.0 1173.0 1215.7 1215.8 1217.7 10775.0 10892.5 11016.0 11020.6 11025.2 4503.1 4683.5 4754.1 4755.7 4763.6 9535.8 9542.3 9543.3 9544.5 9563.3 5275.9 5286.2 5286.8 5287.1 5298.9 4700.6 4706.8 4799.8 4857.8 4882.1 3848.7 3908.3 3950.2 3957.7 3958.7 1163.5 1214.6 1296.2 1303.2 1308.9 636.5 769.2 778.8 784.8 793.1 5435.8 5467.2 5480.2 5569.8 5801.8 1003.8 1011.1 1016.1 1025.8 1036.8 3665.4 3823.7 3848.3 3864.8 3871.1 8503.4 10049.3 10064.7 10206.2 10215.7 9995.7 10064.4 10154.2 10160.6 10162.6 7735.3 7830.8 8011.2 8029.7 8034.4 5407.2 5449.8 5514.2 5549.6 5593.0 9228.5 9260.0 9357.9 9401.2 9514.0 9502.0 9543.0 9558.1 9630.5 9682.6 6721.1 6800.2 6800.8 6880.0 6910.0 7784.5 7801.8 7902.6 7906.4 7913.1 7040.1 7121.1 7150.5 7178.5 7319.1 6960.0 7018.9 7023.2 7045.4 7073.7 6375.0 6386.6 6419.9 6479.1 6479.3 4964.2 4979.5 5004.5 5056.7 5101.3 4938.1 4995.0 4998.3 5115.8 5120.6 13:27:28 INFO - PROCESS | 1655 | 13:27:28 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4418.48 Median:4964.77 stddev:1356.88 (27.3%) stddev-sans-first:1325.96 13:27:28 INFO - PROCESS | 1655 | Values: 354.6 362.7 365.7 374.5 376.0 4592.9 4718.7 4951.7 5154.3 5191.6 4464.2 4969.5 5069.9 5071.5 5168.3 4077.3 4079.0 4081.2 4088.7 4095.4 3748.3 4097.8 4102.6 4109.4 4139.4 3333.7 3927.4 3936.4 3950.2 3972.7 3925.4 3942.7 3943.0 3943.4 3955.6 3161.8 3439.0 3444.2 3468.3 3479.5 4709.8 4952.4 5060.5 5097.9 5105.2 3749.8 4462.1 4484.6 4485.2 4490.0 5227.3 5408.0 5465.1 5501.1 5532.2 3555.8 3691.6 3759.5 3760.8 3819.7 4487.8 5636.3 5655.9 5702.1 5730.0 3228.5 3569.9 3835.5 3841.8 3843.7 3290.6 3874.0 3875.4 3891.7 3910.9 3911.1 4223.0 4285.4 4461.8 4517.5 4811.6 4960.0 5514.7 5530.4 5532.3 1205.8 1215.8 1230.0 1235.4 1259.0 706.8 856.8 863.8 868.6 874.7 4274.9 4458.0 4520.8 4837.0 5002.5 5133.9 5242.3 5394.2 5475.3 5507.6 4364.5 4798.5 5236.4 5241.6 5273.9 2435.5 2836.2 2842.5 2854.9 2863.8 5424.3 5548.5 5647.3 5661.3 5671.7 4819.5 5195.4 5483.1 5510.2 5596.4 5288.0 5402.0 5619.1 5645.5 5656.3 5171.3 5407.2 5673.7 5708.6 5732.4 4393.5 4895.5 5036.3 5482.8 5676.7 5560.5 5911.3 5917.7 5924.9 5924.9 3345.4 3424.0 3746.3 3768.0 3894.3 5698.9 5702.3 5709.1 5712.6 5724.4 5130.0 5409.8 5501.7 5534.4 5627.7 5480.5 5490.1 5498.9 5513.8 5536.3 4372.9 4818.0 5014.2 5188.5 5352.4 5498.8 5501.8 5503.2 5507.0 5526.4 4662.8 5200.3 5366.8 5384.1 5414.6 13:27:28 INFO - PROCESS | 1655 | 13:27:28 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:19899.96 Median:18859.82 stddev:28941.11 (153.5%) stddev-sans-first:28986.37 13:27:28 INFO - PROCESS | 1655 | Values: 693.6 701.7 727.6 733.1 738.5 14754.9 15539.6 15562.6 15633.0 15756.2 14221.3 14385.7 14416.2 15174.8 16040.5 762.6 784.2 785.0 786.8 787.7 776.5 778.2 779.5 779.5 780.1 802.5 819.9 822.3 823.2 824.0 812.8 814.6 814.7 815.7 817.5 608.2 608.6 608.7 608.7 610.1 15333.0 15672.8 15707.1 15718.4 15721.8 13745.9 13794.9 13815.4 13818.4 13900.7 11161.2 11462.3 11536.4 11687.2 11897.3 3592.8 3625.2 3698.8 3822.7 3835.1 117360.0 117584.4 117749.0 118377.8 119771.0 10928.3 11040.1 11085.2 11086.3 11374.4 22292.2 22502.4 22573.0 22688.4 22927.2 7811.8 7836.4 7858.1 7993.1 8064.3 4269.1 4295.7 4300.4 4474.6 4478.6 3603.8 3621.6 3678.8 3703.2 3712.9 666.7 677.2 680.4 680.9 688.4 651.6 666.2 685.9 706.7 713.4 9217.8 10162.8 10866.3 11341.5 11750.9 553.8 580.9 588.6 603.9 715.7 4841.0 5013.9 5029.5 5040.6 5052.3 100699.5 101595.9 101803.5 102056.0 103211.5 61020.0 62844.0 75940.6 80511.0 81488.8 81522.0 81598.0 83598.2 83636.6 84364.0 10711.6 11035.5 11161.9 11204.2 11302.3 47853.0 48829.3 50069.0 52102.0 53508.5 30598.7 30766.4 34126.8 56394.6 58403.4 12716.3 12722.5 12741.4 13184.7 13753.5 13999.4 14185.9 14249.9 14336.6 14539.1 10500.3 13807.0 13946.9 14141.4 14797.3 13535.4 13562.9 14067.9 14082.4 14521.6 13307.0 13316.4 13645.7 13692.9 14312.1 11137.8 11331.5 11580.5 11707.2 11785.2 9198.6 11018.4 11242.7 11252.3 11256.5 13:27:28 INFO - PROCESS | 1655 | -------- Summary: end -------- 13:27:28 INFO - PROCESS | 1655 | 13:27:28 INFO - TEST-INFO | 1655: exit 0 13:27:28 INFO - TEST-OK | dromaeo_css | took 1118147ms 13:27:28 INFO - TEST-START | kraken 13:27:28 INFO - operating with platform_type : mac_ 13:27:28 INFO - Initialising browser for kraken test... 13:27:28 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpzcVAa2/profile http://localhost:49259/getInfo.html) 13:27:31 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 13:27:31 INFO - PROCESS | 1662 | colorDepth:24 13:27:31 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 13:27:31 INFO - PROCESS | 1662 | __metrics 13:27:31 INFO - PROCESS | 1662 | 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" 13:27:31 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:27:32 INFO - TEST-INFO | 1662: exit 0 13:27:32 INFO - Browser initialized. 13:27:32 INFO - Running cycle 1/1 for kraken test... 13:27:32 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpzcVAa2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:44 INFO - PROCESS | 1663 | RSS: Main: 213405696 13:27:44 INFO - PROCESS | 1663 | 13:27:46 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:47 INFO - PROCESS | 1663 | RSS: Main: 264151040 13:27:47 INFO - PROCESS | 1663 | 13:27:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-dft) 13:27:51 INFO - PROCESS | 1663 | RSS: Main: 276590592 13:27:51 INFO - PROCESS | 1663 | 13:27:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-fft) 13:27:54 INFO - PROCESS | 1663 | RSS: Main: 373514240 13:27:54 INFO - PROCESS | 1663 | 13:27:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-oscillator) 13:27:57 INFO - PROCESS | 1663 | RSS: Main: 277737472 13:27:57 INFO - PROCESS | 1663 | 13:27:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49259/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:28:00 INFO - PROCESS | 1663 | RSS: Main: 279306240 13:28:00 INFO - PROCESS | 1663 | 13:28:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49259/tests/kraken/driver.html?testName=imaging-darkroom) 13:28:03 INFO - PROCESS | 1663 | RSS: Main: 319455232 13:28:03 INFO - PROCESS | 1663 | 13:28:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49259/tests/kraken/driver.html?testName=imaging-desaturate) 13:28:06 INFO - PROCESS | 1663 | RSS: Main: 318844928 13:28:06 INFO - PROCESS | 1663 | 13:28:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49259/tests/kraken/driver.html?testName=json-parse-financial) 13:28:10 INFO - PROCESS | 1663 | RSS: Main: 314523648 13:28:10 INFO - PROCESS | 1663 | 13:28:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49259/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:28:12 INFO - PROCESS | 1663 | RSS: Main: 294416384 13:28:12 INFO - PROCESS | 1663 | 13:28:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:28:15 INFO - PROCESS | 1663 | RSS: Main: 297660416 13:28:15 INFO - PROCESS | 1663 | 13:28:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:28:17 INFO - PROCESS | 1663 | RSS: Main: 299319296 13:28:17 INFO - PROCESS | 1663 | 13:28:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:28:21 INFO - PROCESS | 1663 | RSS: Main: 317849600 13:28:21 INFO - PROCESS | 1663 | 13:28:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:28:25 INFO - PROCESS | 1663 | RSS: Main: 311595008 13:28:25 INFO - PROCESS | 1663 | 13:28:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49259/tests/kraken/driver.html?testName=ai-astar) 13:28:27 INFO - PROCESS | 1663 | RSS: Main: 356270080 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | __start_tp_report 13:28:27 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 13:28:27 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 13:28:27 INFO - PROCESS | 1663 | |i|pagename|runs| 13:28:27 INFO - PROCESS | 1663 | |0;ai-astar;109;113;115;115;115;116;114;114;115;115 13:28:27 INFO - PROCESS | 1663 | |1;audio-beat-detection;139;108;105;143;122;108;109;108;126;109 13:28:27 INFO - PROCESS | 1663 | |2;audio-dft;182;184;181;180;186;179;183;181;181;185 13:28:27 INFO - PROCESS | 1663 | |3;audio-fft;83;64;81;113;84;59;59;58;73;58 13:28:27 INFO - PROCESS | 1663 | |4;audio-oscillator;83;70;87;69;67;69;81;67;68;82 13:28:27 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;88;85;88;86;88;84;88;85;88;84 13:28:27 INFO - PROCESS | 1663 | |6;imaging-darkroom;93;93;92;93;92;102;94;93;93;93 13:28:27 INFO - PROCESS | 1663 | |7;imaging-desaturate;135;143;130;84;84;88;86;94;131;86 13:28:27 INFO - PROCESS | 1663 | |8;json-parse-financial;53;53;54;53;57;57;56;55;56;56 13:28:27 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;66;82;75;73;73;68;69;68;69;70 13:28:27 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;84;83;83;82;84;81;85;83;84;82 13:28:27 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;137;139;140;136;136;139;139;143;209;164 13:28:27 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;170;168;168;168;230;182;166;168;165;165 13:28:27 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;66;66;67;66;65;66;66;66;65;65 13:28:27 INFO - PROCESS | 1663 | __end_tp_report 13:28:27 INFO - PROCESS | 1663 | __start_cc_report 13:28:27 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1942 13:28:27 INFO - PROCESS | 1663 | __end_cc_report 13:28:27 INFO - PROCESS | 1663 | __startTimestamp1486848507113__endTimestamp 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | ------- Summary: start ------- 13:28:27 INFO - PROCESS | 1663 | Number of tests: 14 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:1.97 (1.7%) stddev-sans-first:0.87 13:28:27 INFO - PROCESS | 1663 | Values: 109.0 113.0 115.0 115.0 115.0 116.0 114.0 114.0 115.0 115.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:115.50 stddev:14.05 (12.2%) stddev-sans-first:12.61 13:28:27 INFO - PROCESS | 1663 | Values: 139.0 108.0 105.0 143.0 122.0 108.0 109.0 108.0 126.0 109.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:182.20 Median:182.50 stddev:2.25 (1.2%) stddev-sans-first:2.39 13:28:27 INFO - PROCESS | 1663 | Values: 182.0 184.0 181.0 180.0 186.0 179.0 183.0 181.0 181.0 185.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:73.20 Median:68.50 stddev:17.66 (25.8%) stddev-sans-first:18.37 13:28:27 INFO - PROCESS | 1663 | Values: 83.0 64.0 81.0 113.0 84.0 59.0 59.0 58.0 73.0 58.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:74.30 Median:75.50 stddev:7.90 (10.5%) stddev-sans-first:7.73 13:28:27 INFO - PROCESS | 1663 | Values: 83.0 70.0 87.0 69.0 67.0 69.0 81.0 67.0 68.0 82.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:88.00 stddev:1.78 (2.0%) stddev-sans-first:1.79 13:28:27 INFO - PROCESS | 1663 | Values: 88.0 85.0 88.0 86.0 88.0 84.0 88.0 85.0 88.0 84.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:93.00 stddev:2.94 (3.2%) stddev-sans-first:3.10 13:28:27 INFO - PROCESS | 1663 | Values: 93.0 93.0 92.0 93.0 92.0 102.0 94.0 93.0 93.0 93.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:106.10 Median:85.00 stddev:25.05 (29.5%) stddev-sans-first:24.29 13:28:27 INFO - PROCESS | 1663 | Values: 135.0 143.0 130.0 84.0 84.0 88.0 86.0 94.0 131.0 86.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:1.63 (2.9%) stddev-sans-first:1.56 13:28:27 INFO - PROCESS | 1663 | Values: 53.0 53.0 54.0 53.0 57.0 57.0 56.0 55.0 56.0 56.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:4.67 (6.5%) stddev-sans-first:4.54 13:28:27 INFO - PROCESS | 1663 | Values: 66.0 82.0 75.0 73.0 73.0 68.0 69.0 68.0 69.0 70.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:1.20 (1.4%) stddev-sans-first:1.22 13:28:27 INFO - PROCESS | 1663 | Values: 84.0 83.0 83.0 82.0 84.0 81.0 85.0 83.0 84.0 82.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:139.50 stddev:22.89 (16.4%) stddev-sans-first:23.92 13:28:27 INFO - PROCESS | 1663 | Values: 137.0 139.0 140.0 136.0 136.0 139.0 139.0 143.0 209.0 164.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:168.00 stddev:19.93 (11.9%) stddev-sans-first:21.06 13:28:27 INFO - PROCESS | 1663 | Values: 170.0 168.0 168.0 168.0 230.0 182.0 166.0 168.0 165.0 165.0 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 13:28:27 INFO - PROCESS | 1663 | Values: 66.0 66.0 67.0 66.0 65.0 66.0 66.0 66.0 65.0 65.0 13:28:27 INFO - PROCESS | 1663 | -------- Summary: end -------- 13:28:27 INFO - PROCESS | 1663 | 13:28:27 INFO - TEST-INFO | 1663: exit 0 13:28:27 INFO - TEST-OK | kraken | took 59170ms 13:28:27 INFO - SUITE-END | took 1177s 13:28:28 INFO - Completed test suite (00:19:37) 13:28:28 INFO - javascript benchmark 13:28:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.336732653469, 3338.148772063125, 3343.364760695468, 3351.7988920664775, 3397.3375191837586, 5676.687782171984, 5697.173909783079, 5702.0, 5718.914216286754, 5719.999000174974, 4565.2467342888385, 4685.344051832746, 5608.46719561642, 5686.402927692595, 5705.972924873521, 5158.277841102239, 5201.453847346031, 5202.401723801773, 5291.126964050927, 5345.786168553253, 5162.096633089213, 5163.173892177252, 5166.535011848933, 5221.269022336875, 5299.470052994709, 5219.42586315505, 5232.16285394337, 5237.083510385667, 5261.316028916254, 5292.523672869441, 5261.552768014723, 5287.9424115176735, 5296.788128474856, 5296.814611488579, 5298.284731561228, 5094.6688465249645, 5206.088934436459, 5228.9477105229225, 5232.659877107976, 5251.369835619712, 5551.889622075601, 5594.272744543224, 5597.608167428281, 5620.903923734873, 5710.543156547507, 6207.286162091372, 6293.0, 6295.024271237966, 6309.432151106423, 6312.779052733178, 6233.2208473940755, 6340.809775706736, 6342.0, 6350.174477317965, 6351.841203969938, 5673.744681489343, 5716.314042314949, 5825.0971099480075, 5904.97047514764, 5911.527077833763, 5107.259447380109, 6165.475934545524, 6331.68341582919, 6343.5876668016435, 6349.936500635027, 6147.631142131487, 6153.8461538461, 6154.5384096192065, 6157.815265542041, 6162.7843025494785, 6199.504039676815, 6263.498920086382, 6266.780662676875, 6276.968615156895, 6279.560430769893, 5049.646524743306, 6020.909686354708, 6075.513958883279, 6083.300420451705, 6090.939090609126, 6126.724297406628, 6177.876442471125, 6193.411625895533, 6201.193844800147, 6206.875862482725, 4219.346001369792, 4927.310176575283, 4930.7288099154175, 4939.333190019373, 4977.0, 4326.156399502067, 4406.383106365111, 4413.492448368414, 4420.160169567836, 4447.355133505688, 5807.157962095557, 5821.679807610537, 5823.5341172706085, 5846.356900740915, 5857.355690874, 6116.113163591343, 6143.72682107623, 6289.371062893765, 6309.716062777186, 6323.241211054703, 5664.773409063591, 5723.399043100498, 5754.1944127822135, 5778.8266352009505, 5848.444397782204, 5468.91796623051, 5472.343318801769, 5473.2063850742215, 5476.644018138808, 5482.0, 6285.340039295991, 6347.650879201688, 6384.4254017137755, 6386.16979792624, 6386.265579458422, 6137.140800288053, 6195.721192546256, 6229.750809967732, 6269.279032911091, 6278.811635650755, 6342.080398342122, 6352.523560733056, 6369.9681501592195, 6380.840478987877, 6423.582467139621, 6264.749410023548, 6266.655333956493, 6287.779927702509, 6295.087212354091, 6314.273858506331, 5938.554608404301, 6146.354632763674, 6148.231471066117, 6334.429901308904, 6339.96830015847, 6025.8192254232445, 6133.662648554372, 6137.938620613737, 6168.599041062316, 6179.949408600459, 6055.852525353414, 6139.386061393825, 6154.076888466587, 6156.29202641702, 6158.907616385847, 5809.883802323845, 5936.22829032223, 5968.569659937202, 5986.880262394815, 5996.070609055603, 5959.314678811992, 6049.153118563317, 6062.878742425215, 6103.176071230327, 6128.295246046761, 5970.910436343372, 5972.25346831646, 5984.281886173687, 5989.011813050972, 5997.0], "value": 5690.257766651891, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.23099422501974, 459.5657104036687, 470.2663844402731, 490.5633985752681, 501.95733362664197, 31345.216369590773, 33233.51048139944, 33260.5010924836, 33268.667313326856, 33337.83331083341, 42084.78957605208, 44073.338899916525, 44081.779591102, 46346.07307853841, 46513.534864651345, 9344.81310373792, 9504.667336643219, 9538.141567258945, 9544.379615325017, 9555.761105972337, 8481.279091277249, 9381.437113773161, 9495.715128546155, 9496.335256532011, 9570.186534144606, 8483.321334293272, 11253.099752019818, 11494.0, 11533.365664888428, 11710.121740869427, 11360.920712532296, 11394.031507321888, 11460.885391146065, 11501.252418592765, 11520.654380368518, 8477.321814254907, 8688.174623410765, 11378.089752819755, 11455.140864435201, 11488.540458381654, 42658.78670606658, 43318.0, 43358.566414336085, 43519.0, 43576.3463548047, 3977.642012218885, 3981.0, 3988.641022308006, 4004.599540046001, 4004.8598299059686, 29378.853105734335, 29904.40191196164, 31053.534196987064, 31773.682263177536, 31993.84003079993, 3255.869765209389, 3260.8532616032335, 3325.900222993314, 3367.7979321240805, 3372.426687463137, 483216.0, 488154.0, 489085.0, 490491.0, 490851.0, 63328.366716332246, 63630.36369636337, 65594.0, 65843.0, 66058.33941660618, 63477.0, 63585.68207158935, 63769.0, 63817.68091159515, 63830.36169638337, 16893.662126757397, 17095.829041709672, 17100.74348884768, 17102.315907363565, 17110.88779229371, 13091.803622945663, 13215.537456188988, 13226.404811783494, 13237.867621323663, 13238.933805330911, 12534.310612916195, 16032.118233497036, 16071.35714571404, 16705.6658866822, 18189.81810181881, 6543.411093001652, 6734.292899245606, 6799.524033317621, 6869.175698916162, 6917.7232910684015, 861.0, 863.7926897544544, 893.5442924108621, 893.9687110951086, 913.7669894176943, 25890.611640825402, 30625.387492250476, 30851.920182793496, 30980.0, 31346.686533134834, 936.0686117313317, 944.91932528402, 980.4215512847312, 1118.692359601116, 1174.0255587862055, 14492.492762753252, 14886.957912945989, 14902.850971490363, 15203.543893682985, 15224.477552244687, 421222.0, 423987.0, 425464.0, 425731.0, 426001.0, 57840.0, 58003.0, 58062.7096864513, 58100.0, 58313.70843145757, 1428.1431141315336, 1439.5537383411177, 1472.683373074794, 1473.4474572035272, 1478.342137748713, 22544.0, 27419.177424676494, 28002.439951201268, 28729.0, 29265.707342926296, 48630.83899546518, 48712.025759483906, 49019.0196196067, 49052.75473622609, 49079.0, 365544.0, 368544.0, 368733.0, 369290.15354923054, 369614.0, 37456.625433745314, 38687.0, 38750.0, 38820.0, 38951.80524097361, 30711.692883070882, 33330.66669333276, 40700.0, 43569.78215108904, 44609.330860036476, 36314.8184259077, 36482.452763209105, 36794.81602592077, 36840.81579592085, 37141.81429092837, 34290.48564271588, 35118.12204694903, 35938.406159383856, 37729.245415091, 38015.61984380231, 35638.93083207508, 36300.27399452049, 36322.8183859079, 36531.634683652825, 36757.89726308215, 30938.0718578443, 32807.83596082004, 32870.835645821615, 32943.0, 33034.83482582572, 24404.0, 24902.626460602743, 25297.448305105296, 25429.872850635627, 25658.87170564135], "value": 19523.196958477118, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.8669249031613, 374.21788462114176, 396.4489359789891, 405.4303703296867, 426.14557811587764, 14994.40022399104, 15384.769228461568, 17560.912195439036, 20248.39254822354, 20392.395954103857, 20835.687464688042, 20997.580048399024, 21160.94195290237, 21225.57548849022, 21856.235031773893, 5782.24830771999, 5805.24531810865, 6003.219581454427, 6061.515078793686, 6068.969655151718, 4225.957740422603, 5889.8822023559505, 5977.013792724195, 5984.401559844025, 5994.040953447449, 4402.559744025604, 5632.239647647577, 6373.490120790326, 6714.764983225588, 6767.627780472072, 6223.3776622337855, 6532.6407047612365, 6732.865342693168, 6767.458603311723, 6804.761833335834, 5719.857003574903, 5806.912896306559, 5856.7071646417935, 5871.324797648283, 5893.79371721992, 24228.39429014271, 25205.87397063003, 26042.21873343803, 26385.73614263852, 26700.332491687863, 2528.2541650213047, 2565.422779874532, 2610.099515667092, 2621.9606705899428, 2627.5401804684293, 10075.294729368874, 10528.526216320208, 10565.101966332872, 12630.30533320667, 15933.442329518411, 1829.4328758085037, 1829.634073185355, 1837.61410103877, 1838.4208974173093, 1851.1577232359243, 81276.0, 133480.0, 138017.0, 139657.0, 140311.99999999898, 11763.058955283557, 11793.52825886955, 11964.64106076819, 12024.398780060961, 12054.15620906528, 12881.420336084899, 15624.76562851558, 15678.529644110695, 15685.607859803597, 15703.764443533357, 8656.307495400353, 8903.599338029804, 8980.281577473786, 9031.096890310917, 9042.819143617222, 7227.602481863443, 8387.62255698495, 8737.344699147588, 8764.0, 8915.821683566292, 4686.414198225222, 4762.261849413278, 4771.23660214364, 4846.466888642247, 4852.320675105488, 1839.7516335294563, 1980.2969945669367, 2029.5129168999333, 2037.4006404972322, 2044.8159665630164, 977.7018009507169, 989.9703008909744, 993.6025589764153, 996.7308826616772, 1029.552144817007, 20622.896885515478, 21325.786742132692, 22010.669839952414, 23661.645075323882, 23918.760812392, 790.6916302641974, 822.6668199379261, 935.2985261054209, 935.934484586086, 943.5895385507326, 6974.755883544051, 7041.295870412918, 7044.964775176091, 7050.717971281194, 7077.716891324392, 708835.0, 759220.0, 789721.0, 796127.0193648995, 797243.0, 142178.0, 145248.0, 146398.53601464062, 146403.0, 152244.0, 1062.6652604429735, 1074.1514203778927, 1082.718493191776, 1102.1238115698038, 1110.3670907582762, 12468.875311246771, 12592.622221333375, 12634.557790477289, 12771.61685149447, 12808.0, 59881.203563893156, 60563.69718151381, 60915.69542152261, 61285.0, 62828.46058473013, 67173.99239011321, 83769.0, 97440.01188619142, 99051.0, 101722.49138754555, 8394.790130246549, 8485.660573577235, 8595.0, 8712.085231050902, 8746.344024198082, 10674.946625266824, 11732.70668233301, 11963.461644225858, 13695.452181912611, 13797.586072417844, 11258.493367798304, 11302.152338574475, 11554.248973816675, 11838.28970261787, 11850.170488065753, 10030.348027378197, 11377.772444551229, 11403.0, 11570.537178513101, 12003.459844307201, 10898.18263630215, 11542.076633869438, 11908.642740717793, 11919.463624137108, 12073.517059317881, 7064.576125432491, 7587.051618547682, 7738.574378409242, 7918.564478953483, 8844.601992910462, 9271.582778774837, 9808.705738827846, 9873.901260987299, 11597.942010289895, 11722.58970936013], "value": 9763.543572523393, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.246252248651, 1452.6295794572382, 1453.2733633183416, 1462.4077248714275, 1465.6922046370262, 8141.633626486808, 8371.455855369397, 8553.40126191167, 8598.527081010541, 8601.91398086019, 7539.811504712385, 7740.922590774105, 7747.418943579226, 8157.796055098625, 8355.164483551642, 2176.325339144866, 2223.1663126327626, 2224.4550085229143, 2226.9665955010687, 2227.7772222777676, 2263.649134384173, 2356.4815740537056, 2374.157174203159, 2377.821663375245, 2380.75002124777, 2071.2957594417894, 2146.452654573082, 2273.7271527416733, 2334.953300933989, 2354.6468029795583, 2332.5568142052957, 2337.1819863047967, 2339.2163625185585, 2340.660604212388, 2344.308429013428, 2282.805961493275, 2352.447174913894, 2358.2689366296504, 2358.870262135582, 2360.586897292967, 8439.198276163756, 8505.0, 8519.36104792137, 8520.275776559, 8520.829583408358, 5117.232415137759, 5260.473952604747, 5268.736563171826, 5277.86805329866, 5282.709450980195, 3253.3655937092276, 3310.536524886518, 3376.5272861799367, 3407.795532268072, 3413.112590726404, 1168.976620467586, 1172.994135029328, 1215.671768622467, 1215.817627355895, 1217.6955761059735, 10774.999999999922, 10892.509837057352, 11016.008559229627, 11020.614278500214, 11025.228234023622, 4503.1086943483815, 4683.461401938753, 4754.096721622881, 4755.690880092783, 4763.642726795504, 9535.761605959906, 9542.33203675736, 9543.33196676226, 9544.522773861418, 9563.282753793494, 5275.920861187085, 5286.154215325606, 5286.81496147633, 5287.101192797234, 5298.91372268684, 4700.623950083985, 4706.788194531255, 4799.760011999386, 4857.8299759508245, 4882.096812089775, 3848.7113466490127, 3908.3160446921675, 3950.249452603996, 3957.683385329167, 3958.6635136013188, 1163.5229555882047, 1214.5668111628188, 1296.1574976265315, 1303.2115570080155, 1308.9149205301626, 636.4908073541241, 769.1731388757108, 778.7741554949115, 784.7841843493085, 793.0879488588055, 5435.809746658927, 5467.152591348347, 5480.232767412565, 5569.777208911679, 5801.82594522165, 1003.7641154328727, 1011.1001208924064, 1016.1261315268863, 1025.8409946458162, 1036.8341065429645, 3665.3585622515952, 3823.6941044716355, 3848.3265428549894, 3864.845406183721, 3871.05159235989, 8503.447275927168, 10049.346792458467, 10064.69805905824, 10206.23453240995, 10215.693529194135, 9995.650152244636, 10064.39613623185, 10154.238432117472, 10160.644377446753, 10162.593496260066, 7735.303822655988, 7830.804229894298, 8011.1588283230585, 8029.678812847537, 8034.397420193392, 5407.215953686772, 5449.836504904859, 5514.172874068921, 5549.5837812165055, 5593.049181639212, 9228.492432916253, 9259.98618654119, 9357.877054753473, 9401.247900168108, 9514.0, 9501.952490237505, 9543.0456954304, 9558.139767420966, 9630.518474076409, 9682.612695492102, 6721.059051732664, 6800.217974932748, 6800.829979250559, 6880.002399652122, 6910.0, 7784.455088144002, 7801.765947021599, 7902.565358905315, 7906.446548741533, 7913.089994650459, 7040.084788977605, 7121.074260346122, 7150.499465037606, 7178.533395329287, 7319.121705395387, 6959.965200173967, 7018.912068629371, 7023.192332881784, 7045.365917067488, 7073.6816843243205, 6375.043743438521, 6386.616802991835, 6419.903701444388, 6479.092926990131, 6479.287278399278, 4964.180910149785, 4979.477154898828, 5004.524570165829, 5056.721880296619, 5101.260317253903, 4938.061768264019, 4994.9750251248515, 4998.3002379667605, 5115.823360627002, 5120.590352771844], "value": 4428.009384899514, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.6329548916871, 362.7279540344741, 365.72570572070947, 374.47760374277885, 375.97932113733737, 4592.908141837165, 4718.740469274188, 4951.727654978975, 5154.252633368159, 5191.5846732261425, 4464.218761716695, 4969.5030496950285, 5069.923951140736, 5071.478556433074, 5168.2764412982215, 4077.3068578341604, 4078.959865234361, 4081.2245673322122, 4088.672906167514, 4095.4061661059127, 3748.3253014457387, 4097.836086556535, 4102.5692302308125, 4109.404136400235, 4139.441175441322, 3333.666633336671, 3927.3519869221545, 3936.3898595717565, 3950.1902110067367, 3972.682185425159, 3925.3523168677134, 3942.7240093193486, 3942.974826545119, 3943.4084887266854, 3955.5648878623474, 3161.7786754927165, 3438.9828050859587, 3444.2078321986082, 3468.3063387322386, 3479.5128681984543, 4709.764511774431, 4952.430470495903, 5060.508249307965, 5097.898042039175, 5105.243168688903, 3749.8312575933874, 4462.085272519126, 4484.632187182908, 4485.183500682197, 4490.0, 5227.26818245446, 5407.972960135174, 5465.07093794056, 5501.14732216507, 5532.197831314477, 3555.8044307563073, 3691.6492933171576, 3759.5300587426573, 3760.8307626156616, 3819.656230939229, 4487.798049087799, 5636.323641163087, 5655.945789273787, 5702.116171993348, 5729.965862118929, 3228.467302894996, 3569.8929032129076, 3835.520559930009, 3841.8271177797064, 3843.6925045996254, 3290.605127384681, 3873.96126038736, 3875.399313106473, 3891.69628174559, 3910.902227444337, 3911.0720492180058, 4222.9577704223175, 4285.3786201000685, 4461.754603496774, 4517.5256598057385, 4811.604634655981, 4960.032793605213, 5514.696691681996, 5530.446955304518, 5532.28080349552, 1205.806251810701, 1215.750771091924, 1230.0467137967967, 1235.3884827010509, 1258.9990957189057, 706.8338940349014, 856.7643897928119, 863.7883718489011, 868.6091258933506, 874.7244617945327, 4274.935875961863, 4457.977710111429, 4520.751358675238, 4836.960053588496, 5002.549260714352, 5133.897322053538, 5242.344706911636, 5394.217838413408, 5475.315585551806, 5507.5593952483705, 4364.512228029992, 4798.5441383068555, 5236.381809095452, 5241.554467870274, 5273.920891186635, 2435.476372579904, 2836.213185693, 2842.545192769147, 2854.8572571371346, 2863.7852161088003, 5424.349078110652, 5548.500634942875, 5647.265855438849, 5661.264035675335, 5671.6597004179885, 4819.469858315582, 5195.428502864682, 5483.095289277305, 5510.228568000483, 5596.4403559644525, 5287.990563585813, 5402.0, 5619.100943848965, 5645.520130788929, 5656.32124145097, 5171.3277273954145, 5407.215953686772, 5673.723412232214, 5708.628939118944, 5732.426757324234, 4393.494748103881, 4895.4859739728245, 5036.320096787033, 5482.835514934558, 5676.744546495335, 5560.527355174855, 5911.310353789102, 5917.650526862839, 5924.8815023700145, 5924.941415130649, 3345.4312766830185, 3424.0482924732664, 3746.2882052409955, 3768.0, 3894.3379625464304, 5698.886022279448, 5702.346319567279, 5709.115087161496, 5712.600117991867, 5724.427557244242, 5129.9743501282255, 5409.756560954846, 5501.724913754377, 5534.39121696605, 5627.662340259598, 5480.451590010664, 5490.066688663017, 5498.890022199614, 5513.786966867283, 5536.335639723259, 4372.934405983977, 4817.9518204817505, 5014.222795466709, 5188.507091826271, 5352.384475785178, 5498.80754173602, 5501.752421140978, 5503.2114562766465, 5506.972465137809, 5526.447355264602, 4662.836800711959, 5200.323957885451, 5366.812161574326, 5384.065684202197, 5414.563446449035], "value": 3998.8478420931683, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.5699866083029, 701.7158050989348, 727.6434547071937, 733.0836454431957, 738.5421038955847, 14754.852451475483, 15539.611509712262, 15562.610934726637, 15633.0, 15756.212189390528, 14221.288935553233, 14385.712285754278, 14416.207108609022, 15174.772378414333, 16040.518784436486, 762.5729591428803, 784.2001158818002, 784.9921500784976, 786.7679034684782, 787.7439832054577, 776.5418403142145, 778.2140038561066, 779.4777499075633, 779.5439667794319, 780.0600276666603, 802.5265093594778, 819.9139090395512, 822.3298012120104, 823.217942954193, 823.9752807415787, 812.8211793405442, 814.6049166154411, 814.6782021101632, 815.7389635316702, 817.5340056167987, 608.242737791448, 608.5648761135809, 608.7078202462843, 608.7473698415153, 610.0665981049002, 15333.0, 15672.764908526382, 15707.136107514083, 15718.449854255161, 15721.764173537405, 13745.862541374558, 13794.93102534481, 13815.378307976165, 13818.447262109503, 13900.652483687887, 11161.218714689974, 11462.254953428, 11536.365499897502, 11687.181897267195, 11897.28616283017, 3592.8203589820405, 3625.1843335249623, 3698.815059247027, 3822.7132965027454, 3835.137094153821, 117360.0, 117584.41207793992, 117749.0, 118377.8162218384, 119771.0, 10928.289661172157, 11040.116790656728, 11085.22403431752, 11086.33481991067, 11374.431278436045, 22292.21977230789, 22502.437439064153, 22573.0, 22688.432789180402, 22927.19754808607, 7811.843763124819, 7836.412269079842, 7858.1356050834365, 7993.080795708452, 8064.274215320649, 4269.146170765859, 4295.699301048959, 4300.444170326657, 4474.619657329098, 4478.552144785495, 3603.765755225902, 3621.6016238213774, 3678.834452449646, 3703.203811180609, 3712.870049548253, 666.6699983508098, 677.2144312597363, 680.4488364424832, 680.9182898052167, 688.421725750372, 651.5862427358661, 666.1872515531045, 685.8525417035262, 706.7420391557148, 713.4470785141453, 9217.815643687089, 10162.82514254006, 10866.348019118877, 11341.546338146381, 11750.94124529372, 553.8144721518256, 580.9099589563624, 588.632104934416, 603.8852618002566, 715.6743681624848, 4840.95159048405, 5013.874653133628, 5029.547340739351, 5040.57155141817, 5052.34319538465, 100699.49650251702, 101595.9202039895, 101803.49098254461, 102055.97944020465, 103211.45182822263, 61020.0336978095, 62844.0, 75940.62029689817, 80511.0, 81488.77766833502, 81522.0, 81598.0, 83598.16401836026, 83636.58181709053, 84364.0, 10711.571537138427, 11035.503402346752, 11161.88838111641, 11204.215704900906, 11302.265352752045, 47853.0, 48829.2675609859, 50068.998620026665, 52102.0, 53508.464915351906, 30598.694013059583, 30766.384672306875, 34126.82936585301, 56394.59013524531, 58403.4159658398, 12716.337424198056, 12722.491100355883, 12741.426635801596, 13184.670383240496, 13753.518626848012, 13999.44002239899, 14185.858141418454, 14249.857501425267, 14336.56990290293, 14539.127652340894, 10500.317479363817, 13807.0, 13946.930265348608, 14141.363638636492, 14797.260136992893, 13535.390907408993, 13562.864371356554, 14067.929660351632, 14082.436702531784, 14521.636959076108, 13307.0, 13316.400761965928, 13645.727085458433, 13692.931535342259, 14312.141271523742, 11137.83293250618, 11331.546738130382, 11580.536778528765, 11707.180497365103, 11785.233959792586, 9198.586063627019, 11018.39398833072, 11242.66272011841, 11252.26860254081, 11256.493457794255], "value": 7386.146766335361, "unit": "score"}], "name": "dromaeo_css", "value": 7221.873860252956, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 115.0, 115.0, 115.0, 116.0, 114.0, 114.0, 115.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 108.0, 105.0, 143.0, 122.0, 108.0, 109.0, 108.0, 126.0, 109.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 181.0, 180.0, 186.0, 179.0, 183.0, 181.0, 181.0, 185.0], "value": 182.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 64.0, 81.0, 113.0, 84.0, 59.0, 59.0, 58.0, 73.0, 58.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 87.0, 69.0, 67.0, 69.0, 81.0, 67.0, 68.0, 82.0], "value": 74.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 88.0, 84.0, 88.0, 85.0, 88.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 92.0, 93.0, 92.0, 102.0, 94.0, 93.0, 93.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 143.0, 130.0, 84.0, 84.0, 88.0, 86.0, 94.0, 131.0, 86.0], "value": 106.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 57.0, 57.0, 56.0, 55.0, 56.0, 56.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 82.0, 75.0, 73.0, 73.0, 68.0, 69.0, 68.0, 69.0, 70.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 82.0, 84.0, 81.0, 85.0, 83.0, 84.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 140.0, 136.0, 136.0, 139.0, 139.0, 143.0, 209.0, 164.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 168.0, 168.0, 230.0, 182.0, 166.0, 168.0, 165.0, 165.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1446.1999999999998, "alertThreshold": 2.0}]} 13:28:28 INFO - Return code: 0 13:28:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:28:28 ERROR - # TBPL SUCCESS # 13:28:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:28:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:28:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:28:28 INFO - 2017-02-11 13:28:28.402 screenresolution[1667:12497] starting screenresolution argv=screenresolution get 13:28:28 INFO - 2017-02-11 13:28:28.404 screenresolution[1667:12497] Display 0: 1600x1200x32@60 13:28:28 INFO - 2017-02-11 13:28:28.410 screenresolution[1668:12500] starting screenresolution argv=screenresolution list 13:28:28 INFO - Available Modes on Display 0 13:28:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:28:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:28:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:28:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:28:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:28:28 INFO - Intel Iris: 13:28:28 INFO - Chipset Model: Intel Iris 13:28:28 INFO - Type: GPU 13:28:28 INFO - Bus: Built-In 13:28:28 INFO - VRAM (Dynamic, Max): 1536 MB 13:28:28 INFO - Vendor: Intel (0x8086) 13:28:28 INFO - Device ID: 0x0a2e 13:28:28 INFO - Revision ID: 0x0009 13:28:28 INFO - Displays: 13:28:28 INFO - Display: 13:28:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:28:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:28:28 INFO - Display Serial Number: 1600x1200 60 13:28:28 INFO - Main Display: Yes 13:28:28 INFO - Mirror: Off 13:28:28 INFO - Online: Yes 13:28:28 INFO - Rotation: Supported 13:28:28 INFO - Return code: 0 13:28:28 INFO - Running post-action listener: _resource_record_post_action 13:28:28 INFO - [mozharness: 2017-02-11 21:28:28.646377Z] Finished run-tests step (success) 13:28:28 INFO - Running post-run listener: _resource_record_post_run 13:28:28 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 32427008; Write bytes: 510587904; Read time: 195; Write time: 1608 13:28:28 INFO - TinderboxPrint: CPU usage
53.4% 13:28:28 INFO - TinderboxPrint: I/O read bytes / time
32,427,008 / 195 13:28:28 INFO - TinderboxPrint: I/O write bytes / time
510,587,904 / 1,608 13:28:28 INFO - TinderboxPrint: CPU idle
2,232.4 (46.6%) 13:28:28 INFO - TinderboxPrint: CPU system
956.7 (20.0%) 13:28:28 INFO - TinderboxPrint: CPU user
1,604.6 (33.5%) 13:28:28 INFO - TinderboxPrint: Swap in / out
235,761,664 / 0 13:28:28 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207483392; Write bytes: 201387520; Read time: 15805; Write time: 457 13:28:28 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 28920832; Write bytes: 299148800; Read time: 172; Write time: 1116 13:28:29 INFO - Running post-run listener: _upload_blobber_files 13:28:29 INFO - Blob upload gear active. 13:28:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:28:29 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 13:28:29 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'] 13:28:29 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 13:28:29 INFO - (blobuploader) - INFO - Open directory for files ... 13:28:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:28:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:28:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:30 INFO - (blobuploader) - INFO - Done attempting. 13:28:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:28:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:28:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:31 INFO - (blobuploader) - INFO - Done attempting. 13:28:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:28:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:28:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:32 INFO - (blobuploader) - INFO - Done attempting. 13:28:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:28:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:28:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:34 INFO - (blobuploader) - INFO - Done attempting. 13:28:34 INFO - (blobuploader) - INFO - Iteration through files over. 13:28:34 INFO - Return code: 0 13:28:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:28:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:28:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc3018c272c7cb508a37dc5bbfa212cb50d94d8c6ff81d3329c987d44d220808d225b72d738d365649cb7e61ed53ba23da6751a9b21c15cc24cf407a608ca9fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af6bddf8fcfcd2dadd1125b2d052081072bd2fe6d6e48c9bd6dffec747b056f5a54007340a4205ddebe7a4ec14a9fce3debad9548b663660010ae08470f5c116", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee31b144801319799acd025e7823da796b7e1bbb78421788294f73224a07926a9880efe81fc6bb2fa9a34f6973514a0771e10c71bc8145c9610cfd0b97917f53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d7842d3c07457b6d921d42c56e6717a59e5fa1c2b063f8299d78ae5569b1522e2a90de1a452c21b5e9dbdecf73037da86c5d9e0b6d0071e879c71d3e6ce0cd9"} 13:28:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:28:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:28:34 INFO - Contents: 13:28:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc3018c272c7cb508a37dc5bbfa212cb50d94d8c6ff81d3329c987d44d220808d225b72d738d365649cb7e61ed53ba23da6751a9b21c15cc24cf407a608ca9fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af6bddf8fcfcd2dadd1125b2d052081072bd2fe6d6e48c9bd6dffec747b056f5a54007340a4205ddebe7a4ec14a9fce3debad9548b663660010ae08470f5c116", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee31b144801319799acd025e7823da796b7e1bbb78421788294f73224a07926a9880efe81fc6bb2fa9a34f6973514a0771e10c71bc8145c9610cfd0b97917f53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d7842d3c07457b6d921d42c56e6717a59e5fa1c2b063f8299d78ae5569b1522e2a90de1a452c21b5e9dbdecf73037da86c5d9e0b6d0071e879c71d3e6ce0cd9"} 13:28:34 INFO - Running post-run listener: copy_logs_to_upload_dir 13:28:34 INFO - Copying logs to upload dir... 13:28:34 INFO - mkdir: /builds/slave/test/build/upload/logs 13:28:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.832733 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-11 13:28:34.810418) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-11 13:28:34.813670) ========= 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.MwLbrVfNLC/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.jaANf9CNTq/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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/fc3018c272c7cb508a37dc5bbfa212cb50d94d8c6ff81d3329c987d44d220808d225b72d738d365649cb7e61ed53ba23da6751a9b21c15cc24cf407a608ca9fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af6bddf8fcfcd2dadd1125b2d052081072bd2fe6d6e48c9bd6dffec747b056f5a54007340a4205ddebe7a4ec14a9fce3debad9548b663660010ae08470f5c116", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee31b144801319799acd025e7823da796b7e1bbb78421788294f73224a07926a9880efe81fc6bb2fa9a34f6973514a0771e10c71bc8145c9610cfd0b97917f53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d7842d3c07457b6d921d42c56e6717a59e5fa1c2b063f8299d78ae5569b1522e2a90de1a452c21b5e9dbdecf73037da86c5d9e0b6d0071e879c71d3e6ce0cd9"} build_url:https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011086 build_url: 'https://queue.taskcluster.net/v1/task/GGPIkNOBTneyPx90galzqA/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/fc3018c272c7cb508a37dc5bbfa212cb50d94d8c6ff81d3329c987d44d220808d225b72d738d365649cb7e61ed53ba23da6751a9b21c15cc24cf407a608ca9fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af6bddf8fcfcd2dadd1125b2d052081072bd2fe6d6e48c9bd6dffec747b056f5a54007340a4205ddebe7a4ec14a9fce3debad9548b663660010ae08470f5c116", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee31b144801319799acd025e7823da796b7e1bbb78421788294f73224a07926a9880efe81fc6bb2fa9a34f6973514a0771e10c71bc8145c9610cfd0b97917f53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d7842d3c07457b6d921d42c56e6717a59e5fa1c2b063f8299d78ae5569b1522e2a90de1a452c21b5e9dbdecf73037da86c5d9e0b6d0071e879c71d3e6ce0cd9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-11 13:28:34.851601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 13:28:34.852089) ========= 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.MwLbrVfNLC/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.jaANf9CNTq/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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.005220 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 13:28:34.904729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-11 13:28:34.905071) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-11 13:28:34.905605) ========= ========= Total master_lag: 0.19 =========