builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0301 starttime: 1484516934.56 results: success (0) buildid: 20170115123323 builduid: d65d6de2bc8c4f6387b70ab2f3e8371e revision: 829f16159b89b921eb81e0f26954ef54ae55034b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 13:48:54.562253) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 13:48:54.563116) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 13:48:54.563522) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 13:48:54.623830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 13:48:54.624208) ========= 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.kwvS82Deg4/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.3GQ56AqYvf/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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-01-15 13:48:54-- 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% 28.3M=0s 2017-01-15 13:48:55 (28.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.638980 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 13:48:55.291169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 13:48:55.291516) ========= 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.kwvS82Deg4/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.3GQ56AqYvf/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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.025767 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 13:48:55.340886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-15 13:48:55.341255) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 829f16159b89b921eb81e0f26954ef54ae55034b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 829f16159b89b921eb81e0f26954ef54ae55034b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kwvS82Deg4/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.3GQ56AqYvf/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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-01-15 13:48:55,446 truncating revision to first 12 chars 2017-01-15 13:48:55,446 Setting DEBUG logging. 2017-01-15 13:48:55,446 attempt 1/10 2017-01-15 13:48:55,446 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/829f16159b89?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-15 13:48:56,431 unpacking tar archive at: mozilla-central-829f16159b89/testing/mozharness/ program finished with exit code 0 elapsedTime=1.262549 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-15 13:48:56.627258) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 13:48:56.627578) ========= script_repo_revision: 829f16159b89b921eb81e0f26954ef54ae55034b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 13:48:56.627983) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 13:48:56.628248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 13:48:56.648004) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-15 13:48:56.648394) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kwvS82Deg4/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.3GQ56AqYvf/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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:48:56 INFO - MultiFileLogger online at 20170115 13:48:56 in /builds/slave/test 13:48:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:48:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:48:56 INFO - {'append_to_log': False, 13:48:56 INFO - 'base_work_dir': '/builds/slave/test', 13:48:56 INFO - 'blob_upload_branch': 'Firefox', 13:48:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:48:56 INFO - 'branch': 'Firefox', 13:48:56 INFO - 'buildbot_json_path': 'buildprops.json', 13:48:56 INFO - 'config_files': ('talos/mac_config.py',), 13:48:56 INFO - 'default_actions': ('clobber', 13:48:56 INFO - 'read-buildbot-config', 13:48:56 INFO - 'download-and-extract', 13:48:56 INFO - 'populate-webroot', 13:48:56 INFO - 'create-virtualenv', 13:48:56 INFO - 'install', 13:48:56 INFO - 'run-tests'), 13:48:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:48:56 INFO - 'download_minidump_stackwalk': True, 13:48:56 INFO - 'download_symbols': 'ondemand', 13:48:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:48:56 INFO - 'tooltool.py': '/tools/tooltool.py', 13:48:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:48:56 INFO - '/tools/misc-python/virtualenv.py')}, 13:48:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:48:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:48:56 INFO - 'installer_path': 'installer.exe', 13:48:56 INFO - 'log_level': 'info', 13:48:56 INFO - 'log_name': 'talos', 13:48:56 INFO - 'log_to_console': True, 13:48:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:48:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:48:56 INFO - 'opt_config_files': (), 13:48:56 INFO - 'pip_index': False, 13:48:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:56 INFO - 'cmd': ('bash', 13:48:56 INFO - '-c', 13:48:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:56 INFO - 'enabled': True, 13:48:56 INFO - 'halt_on_failure': False, 13:48:56 INFO - 'name': 'check_screen_resolution'},), 13:48:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:56 INFO - 'cmd': ('bash', 13:48:56 INFO - '-c', 13:48:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:56 INFO - 'enabled': True, 13:48:56 INFO - 'halt_on_failure': False, 13:48:56 INFO - 'name': 'check_screen_resolution'},), 13:48:56 INFO - 'run_cmd_checks_enabled': True, 13:48:56 INFO - 'sps_profile': False, 13:48:56 INFO - 'sps_profile_interval': 0, 13:48:56 INFO - 'suite': 'dromaeojs', 13:48:56 INFO - 'system_bits': '32', 13:48:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:48:56 INFO - 'title': 't-yosemite-r7-0301', 13:48:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:48:56 INFO - 'use_talos_json': True, 13:48:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:48:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:48:56 INFO - 'work_dir': 'build'} 13:48:56 INFO - [mozharness: 2017-01-15 21:48:56.860832Z] Running clobber step. 13:48:56 INFO - Running pre-action listener: _resource_record_pre_action 13:48:56 INFO - Running main action method: clobber 13:48:56 INFO - rmtree: /builds/slave/test/build 13:48:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:48:59 INFO - Running post-action listener: _resource_record_post_action 13:48:59 INFO - [mozharness: 2017-01-15 21:48:59.379209Z] Finished clobber step (success) 13:48:59 INFO - [mozharness: 2017-01-15 21:48:59.379438Z] Running read-buildbot-config step. 13:48:59 INFO - Running pre-action listener: _resource_record_pre_action 13:48:59 INFO - Running main action method: read_buildbot_config 13:48:59 INFO - Using buildbot properties: 13:48:59 INFO - { 13:48:59 INFO - "project": "", 13:48:59 INFO - "product": "firefox", 13:48:59 INFO - "script_repo_revision": "production", 13:48:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 13:48:59 INFO - "repository": "", 13:48:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 13:48:59 INFO - "buildid": "20170115123323", 13:48:59 INFO - "pgo_build": "False", 13:48:59 INFO - "basedir": "/builds/slave/test", 13:48:59 INFO - "buildnumber": 25, 13:48:59 INFO - "slavename": "t-yosemite-r7-0301", 13:48:59 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:48:59 INFO - "platform": "yosemite_r7", 13:48:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:48:59 INFO - "branch": "mozilla-central", 13:48:59 INFO - "repo_path": "mozilla-central", 13:48:59 INFO - "revision": "829f16159b89b921eb81e0f26954ef54ae55034b", 13:48:59 INFO - "stage_platform": "macosx64", 13:48:59 INFO - "builduid": "d65d6de2bc8c4f6387b70ab2f3e8371e", 13:48:59 INFO - "slavebuilddir": "test" 13:48:59 INFO - } 13:48:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 13:48:59 INFO - Running post-action listener: _resource_record_post_action 13:48:59 INFO - [mozharness: 2017-01-15 21:48:59.383467Z] Finished read-buildbot-config step (success) 13:48:59 INFO - [mozharness: 2017-01-15 21:48:59.383593Z] Running download-and-extract step. 13:48:59 INFO - Running pre-action listener: _resource_record_pre_action 13:48:59 INFO - Running main action method: download_and_extract 13:48:59 INFO - mkdir: /builds/slave/test/build/tests 13:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:59 INFO - trying https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 13:48:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 13:48:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 13:49:00 INFO - Downloaded 1199 bytes. 13:49:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 13:49:00 INFO - Using the following test package requirements: 13:49:00 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 13:49:00 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:49:00 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 13:49:00 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:49:00 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 13:49:00 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:49:00 INFO - u'jsshell-mac.zip'], 13:49:00 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:49:00 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 13:49:00 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 13:49:00 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:49:00 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 13:49:00 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:49:00 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 13:49:00 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:49:00 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 13:49:00 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:49:00 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 13:49:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:49:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 13:49:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:49:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 13:49:01 INFO - Expected file size: 16319074 13:49:01 INFO - Obtained file size: 16319074 13:49:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:49:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 13:49:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:49:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 13:49:09 INFO - Expected file size: 16319074 13:49:09 INFO - Obtained file size: 16319074 13:49:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 13:49:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:49:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 13:49:17 INFO - Expected file size: 14403463 13:49:17 INFO - Obtained file size: 14403463 13:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:17 INFO - trying https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 13:49:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 13:49:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 13:49:19 INFO - Downloaded 70070158 bytes. 13:49:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 13:49:19 INFO - mkdir: /builds/slave/test/properties 13:49:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:49:19 INFO - Writing to file /builds/slave/test/properties/build_url 13:49:19 INFO - Contents: 13:49:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 13:49:20 INFO - Running post-action listener: _resource_record_post_action 13:49:20 INFO - Running post-action listener: set_extra_try_arguments 13:49:20 INFO - [mozharness: 2017-01-15 21:49:20.146136Z] Finished download-and-extract step (success) 13:49:20 INFO - [mozharness: 2017-01-15 21:49:20.146262Z] Running populate-webroot step. 13:49:20 INFO - Running pre-action listener: _resource_record_pre_action 13:49:20 INFO - Running main action method: populate_webroot 13:49:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:49:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:49:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:49:20 INFO - '--tppagecycles', 13:49:20 INFO - '7'], 13:49:20 INFO - 'tests': ['tsvgm']}}, 13:49:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:49:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:49:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:49:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:49:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:49:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:49:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:49:20 INFO - 'talos_options': ['--disable-e10s'], 13:49:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:49:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:49:20 INFO - 'talos_options': ['--disable-e10s'], 13:49:20 INFO - 'tests': ['damp', 'tps']}, 13:49:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:49:20 INFO - 'tests': ['damp', 'tps']}, 13:49:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:49:20 INFO - 'tests': ['dromaeo_dom']}, 13:49:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:49:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:49:20 INFO - 'tests': ['basic_compositor_video']}, 13:49:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:49:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:49:20 INFO - 'tests': ['a11yr', 13:49:20 INFO - 'ts_paint', 13:49:20 INFO - 'tpaint', 13:49:20 INFO - 'sessionrestore', 13:49:20 INFO - 'sessionrestore_no_auto_restore', 13:49:20 INFO - 'tabpaint']}, 13:49:20 INFO - 'other-e10s': {'tests': ['a11yr', 13:49:20 INFO - 'ts_paint', 13:49:20 INFO - 'tpaint', 13:49:20 INFO - 'sessionrestore', 13:49:20 INFO - 'sessionrestore_no_auto_restore', 13:49:20 INFO - 'tabpaint']}, 13:49:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:49:20 INFO - 'ts_paint', 13:49:20 INFO - 'tpaint', 13:49:20 INFO - 'sessionrestore', 13:49:20 INFO - 'sessionrestore_no_auto_restore', 13:49:20 INFO - 'tabpaint']}, 13:49:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:49:20 INFO - 'ts_paint', 13:49:20 INFO - 'tpaint', 13:49:20 INFO - 'sessionrestore', 13:49:20 INFO - 'sessionrestore_no_auto_restore', 13:49:20 INFO - 'tabpaint']}, 13:49:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:49:20 INFO - 'tests': ['a11yr', 13:49:20 INFO - 'ts_paint', 13:49:20 INFO - 'tpaint', 13:49:20 INFO - 'sessionrestore', 13:49:20 INFO - 'sessionrestore_no_auto_restore', 13:49:20 INFO - 'tabpaint']}, 13:49:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:49:20 INFO - 'tests': ['a11yr', 13:49:20 INFO - 'ts_paint', 13:49:20 INFO - 'tpaint', 13:49:20 INFO - 'sessionrestore', 13:49:20 INFO - 'sessionrestore_no_auto_restore', 13:49:20 INFO - 'tabpaint']}, 13:49:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:49:20 INFO - 'tests': ['tsvgx', 13:49:20 INFO - 'tsvgr_opacity', 13:49:20 INFO - 'tart', 13:49:20 INFO - 'tscrollx', 13:49:20 INFO - 'cart', 13:49:20 INFO - 'tsvg_static']}, 13:49:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:49:20 INFO - 'tsvgr_opacity', 13:49:20 INFO - 'tart', 13:49:20 INFO - 'tscrollx', 13:49:20 INFO - 'cart', 13:49:20 INFO - 'tsvg_static']}, 13:49:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:49:20 INFO - 'talos_options': ['--disable-e10s'], 13:49:20 INFO - 'tests': ['tp5o']}, 13:49:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:49:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:49:20 INFO - 'talos_options': ['--disable-e10s', 13:49:20 INFO - '--xperf_path', 13:49:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:20 INFO - 'tests': ['tp5n']}, 13:49:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:49:20 INFO - 'talos_options': ['--xperf_path', 13:49:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:20 INFO - 'tests': ['tp5n']}}, 13:49:20 INFO - 'talos.zip': {'path': '', 13:49:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:49:20 INFO - Running post-action listener: _resource_record_post_action 13:49:20 INFO - [mozharness: 2017-01-15 21:49:20.164916Z] Finished populate-webroot step (success) 13:49:20 INFO - [mozharness: 2017-01-15 21:49:20.165026Z] Running create-virtualenv step. 13:49:20 INFO - Running pre-action listener: _resource_record_pre_action 13:49:20 INFO - Running main action method: create_virtualenv 13:49:20 INFO - Creating virtualenv /builds/slave/test/build/venv 13:49:20 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:49:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:49:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:49:20 INFO - Using real prefix '/tools/python27' 13:49:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:49:21 INFO - Installing distribute.............................................................................................................................................................................................done. 13:49:23 INFO - Installing pip.................done. 13:49:23 INFO - Return code: 0 13:49:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:49:24 INFO - Reading from file tmpfile_stdout 13:49:24 INFO - Output received: 13:49:24 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:49:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:49: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:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:24 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 0x10f218b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f21b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349446b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6d30>, '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 0x10ef1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efebbe8>, '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.kwvS82Deg4/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.3GQ56AqYvf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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:49:24 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:49:24 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:49:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwvS82Deg4/Render', 13:49:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:24 INFO - 'HOME': '/Users/cltbld', 13:49:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:24 INFO - 'LOGNAME': 'cltbld', 13:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:24 INFO - 'MOZ_NO_REMOTE': '1', 13:49:24 INFO - 'NO_EM_RESTART': '1', 13:49:24 INFO - 'PAGER': '/bin/cat', 13:49:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:24 INFO - 'PWD': '/builds/slave/test', 13:49:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:24 INFO - 'SHELL': '/bin/bash', 13:49:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GQ56AqYvf/Listeners', 13:49:24 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 13:49:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:24 INFO - 'USER': 'cltbld', 13:49:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:24 INFO - 'XPC_FLAGS': '0x0', 13:49:24 INFO - 'XPC_SERVICE_NAME': '0', 13:49:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:24 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:49:24 INFO - Cleaning up... 13:49:24 INFO - Return code: 0 13:49:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:49: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:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:24 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 0x10f218b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f21b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349446b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6d30>, '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 0x10ef1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efebbe8>, '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.kwvS82Deg4/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.3GQ56AqYvf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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:49:24 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:49:24 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:49:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwvS82Deg4/Render', 13:49:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:24 INFO - 'HOME': '/Users/cltbld', 13:49:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:24 INFO - 'LOGNAME': 'cltbld', 13:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:24 INFO - 'MOZ_NO_REMOTE': '1', 13:49:24 INFO - 'NO_EM_RESTART': '1', 13:49:24 INFO - 'PAGER': '/bin/cat', 13:49:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:24 INFO - 'PWD': '/builds/slave/test', 13:49:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:24 INFO - 'SHELL': '/bin/bash', 13:49:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GQ56AqYvf/Listeners', 13:49:24 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 13:49:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:24 INFO - 'USER': 'cltbld', 13:49:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:24 INFO - 'XPC_FLAGS': '0x0', 13:49:24 INFO - 'XPC_SERVICE_NAME': '0', 13:49:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:24 INFO - Downloading/unpacking psutil>=3.1.1 13:49:24 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:49:24 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:49:24 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:49:24 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:49:24 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:49:24 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:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:49:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:28 INFO - Installing collected packages: psutil 13:49:28 INFO - Running setup.py install for psutil 13:49:28 INFO - building 'psutil._psutil_osx' extension 13:49:28 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:49:29 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:49:29 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:49:29 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:49:29 INFO - building 'psutil._psutil_posix' extension 13:49:29 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:49:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:49:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:49:29 INFO - ^ 13:49:29 INFO - 1 warning generated. 13:49:29 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:49:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:29 INFO - Successfully installed psutil 13:49:29 INFO - Cleaning up... 13:49:29 INFO - Return code: 0 13:49:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:49: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:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f218b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f21b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349446b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6d30>, '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 0x10ef1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efebbe8>, '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.kwvS82Deg4/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.3GQ56AqYvf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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:49: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:49: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 mozsystemmonitor==0.3 13:49:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwvS82Deg4/Render', 13:49:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:29 INFO - 'HOME': '/Users/cltbld', 13:49:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:29 INFO - 'LOGNAME': 'cltbld', 13:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:29 INFO - 'MOZ_NO_REMOTE': '1', 13:49:29 INFO - 'NO_EM_RESTART': '1', 13:49:29 INFO - 'PAGER': '/bin/cat', 13:49:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:29 INFO - 'PWD': '/builds/slave/test', 13:49:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:29 INFO - 'SHELL': '/bin/bash', 13:49:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GQ56AqYvf/Listeners', 13:49:29 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 13:49:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:29 INFO - 'USER': 'cltbld', 13:49:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:29 INFO - 'XPC_FLAGS': '0x0', 13:49:29 INFO - 'XPC_SERVICE_NAME': '0', 13:49:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:49:30 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:49:30 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:49:30 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:49:30 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:49:30 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:49:30 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:49:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:49:32 INFO - Installing collected packages: mozsystemmonitor 13:49:32 INFO - Running setup.py install for mozsystemmonitor 13:49:32 INFO - Successfully installed mozsystemmonitor 13:49:32 INFO - Cleaning up... 13:49:33 INFO - Return code: 0 13:49:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:33 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 0x10f218b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f21b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349446b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6d30>, '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 0x10ef1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efebbe8>, '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.kwvS82Deg4/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.3GQ56AqYvf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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:49:33 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:49:33 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:49:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwvS82Deg4/Render', 13:49:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:33 INFO - 'HOME': '/Users/cltbld', 13:49:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:33 INFO - 'LOGNAME': 'cltbld', 13:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:33 INFO - 'MOZ_NO_REMOTE': '1', 13:49:33 INFO - 'NO_EM_RESTART': '1', 13:49:33 INFO - 'PAGER': '/bin/cat', 13:49:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:33 INFO - 'PWD': '/builds/slave/test', 13:49:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:33 INFO - 'SHELL': '/bin/bash', 13:49:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GQ56AqYvf/Listeners', 13:49:33 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 13:49:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:33 INFO - 'USER': 'cltbld', 13:49:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:33 INFO - 'XPC_FLAGS': '0x0', 13:49:33 INFO - 'XPC_SERVICE_NAME': '0', 13:49:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:33 INFO - Downloading/unpacking jsonschema==2.5.1 13:49:33 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:49:33 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:49:33 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:49:33 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:49:33 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:49:33 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:49:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:49:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:49:35 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:49:35 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:49:35 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:49:35 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:49:35 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:49:35 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:49:36 INFO - Downloading functools32-3.2.3-2.tar.gz 13:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:49:36 INFO - warning: no files found matching '*.txt' 13:49:36 INFO - no previously-included directories found matching 'build' 13:49:36 INFO - no previously-included directories found matching 'dist' 13:49:36 INFO - no previously-included directories found matching '.git*' 13:49:36 INFO - Installing collected packages: jsonschema, functools32 13:49:36 INFO - Running setup.py install for functools32 13:49:36 INFO - warning: no files found matching '*.txt' 13:49:36 INFO - no previously-included directories found matching 'build' 13:49:36 INFO - no previously-included directories found matching 'dist' 13:49:36 INFO - no previously-included directories found matching '.git*' 13:49:36 INFO - Successfully installed jsonschema functools32 13:49:36 INFO - Cleaning up... 13:49:36 INFO - Return code: 0 13:49:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:49: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:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f218b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f21b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349446b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6d30>, '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 0x10ef1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efebbe8>, '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.kwvS82Deg4/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.3GQ56AqYvf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:49:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwvS82Deg4/Render', 13:49:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:36 INFO - 'HOME': '/Users/cltbld', 13:49:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:36 INFO - 'LOGNAME': 'cltbld', 13:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:36 INFO - 'MOZ_NO_REMOTE': '1', 13:49:36 INFO - 'NO_EM_RESTART': '1', 13:49:36 INFO - 'PAGER': '/bin/cat', 13:49:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:36 INFO - 'PWD': '/builds/slave/test', 13:49:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:36 INFO - 'SHELL': '/bin/bash', 13:49:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GQ56AqYvf/Listeners', 13:49:36 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 13:49:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:36 INFO - 'USER': 'cltbld', 13:49:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:36 INFO - 'XPC_FLAGS': '0x0', 13:49:36 INFO - 'XPC_SERVICE_NAME': '0', 13:49:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:49:36 INFO - Cleaning up... 13:49:36 INFO - Return code: 0 13:49:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:49: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:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f218b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f21b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349446b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6d30>, '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 0x10ef1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efebbe8>, '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.kwvS82Deg4/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.3GQ56AqYvf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:49:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwvS82Deg4/Render', 13:49:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:36 INFO - 'HOME': '/Users/cltbld', 13:49:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:36 INFO - 'LOGNAME': 'cltbld', 13:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:36 INFO - 'MOZ_NO_REMOTE': '1', 13:49:36 INFO - 'NO_EM_RESTART': '1', 13:49:36 INFO - 'PAGER': '/bin/cat', 13:49:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:36 INFO - 'PWD': '/builds/slave/test', 13:49:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:36 INFO - 'SHELL': '/bin/bash', 13:49:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GQ56AqYvf/Listeners', 13:49:36 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 13:49:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:36 INFO - 'USER': 'cltbld', 13:49:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:36 INFO - 'XPC_FLAGS': '0x0', 13:49:36 INFO - 'XPC_SERVICE_NAME': '0', 13:49:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:37 INFO - Downloading/unpacking blobuploader==1.2.4 13:49:37 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:49:37 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:49:37 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:49:37 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:49:37 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:49:37 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:49:39 INFO - Downloading blobuploader-1.2.4.tar.gz 13:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:49:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:49:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:49:40 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:49:40 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:49:40 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:49:40 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:49:40 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:49:40 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:49:41 INFO - Downloading docopt-0.6.1.tar.gz 13:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:49:41 INFO - Installing collected packages: blobuploader, requests, docopt 13:49:41 INFO - Running setup.py install for blobuploader 13:49:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:49:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:49:41 INFO - Running setup.py install for requests 13:49:41 INFO - Running setup.py install for docopt 13:49:41 INFO - Successfully installed blobuploader requests docopt 13:49:41 INFO - Cleaning up... 13:49:42 INFO - Return code: 0 13:49:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:42 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 0x10f218b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f21b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349446b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6d30>, '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 0x10ef1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efebbe8>, '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.kwvS82Deg4/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.3GQ56AqYvf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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:49:42 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:49:42 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:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwvS82Deg4/Render', 13:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:42 INFO - 'HOME': '/Users/cltbld', 13:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:42 INFO - 'LOGNAME': 'cltbld', 13:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:42 INFO - 'MOZ_NO_REMOTE': '1', 13:49:42 INFO - 'NO_EM_RESTART': '1', 13:49:42 INFO - 'PAGER': '/bin/cat', 13:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:42 INFO - 'PWD': '/builds/slave/test', 13:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:42 INFO - 'SHELL': '/bin/bash', 13:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GQ56AqYvf/Listeners', 13:49:42 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 13:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:42 INFO - 'USER': 'cltbld', 13:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:42 INFO - 'XPC_FLAGS': '0x0', 13:49:42 INFO - 'XPC_SERVICE_NAME': '0', 13:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:42 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-FGNVxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:42 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-1L5klR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:42 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-16vrMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:42 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-_CyDi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:42 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-NoDOKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:42 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-a2HiFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:42 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-mHY7lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:43 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-uLlg6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:43 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-jP7Nvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:43 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-8bXkAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:43 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-flRlUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:43 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-YFAPJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:43 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-aclqEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:43 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-nm34y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:43 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-Sly_D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:43 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-U11nzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:44 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-WrJ3Le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:49:44 INFO - Running setup.py install for manifestparser 13:49:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:49:44 INFO - Running setup.py install for mozcrash 13:49:44 INFO - Running setup.py install for mozdebug 13:49:44 INFO - Running setup.py install for mozdevice 13:49:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:49:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:49:44 INFO - Running setup.py install for mozfile 13:49:44 INFO - Running setup.py install for mozhttpd 13:49:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:49:45 INFO - Running setup.py install for mozinfo 13:49:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:49:45 INFO - Running setup.py install for mozInstall 13:49:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:49:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:49:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:49:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:49:45 INFO - Running setup.py install for mozleak 13:49:45 INFO - Running setup.py install for mozlog 13:49:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:49:45 INFO - Running setup.py install for moznetwork 13:49:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:49:45 INFO - Running setup.py install for mozprocess 13:49:45 INFO - Running setup.py install for mozprofile 13:49:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:49:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:49:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:49:46 INFO - Running setup.py install for mozrunner 13:49:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:49:46 INFO - Running setup.py install for mozscreenshot 13:49:46 INFO - Running setup.py install for moztest 13:49:46 INFO - Running setup.py install for mozversion 13:49:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:49:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:49:46 INFO - Cleaning up... 13:49:46 INFO - Return code: 0 13:49:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:46 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 0x10f218b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f21b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349446b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6d30>, '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 0x10ef1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efebbe8>, '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.kwvS82Deg4/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.3GQ56AqYvf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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:49:46 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:49:46 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:49:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwvS82Deg4/Render', 13:49:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:46 INFO - 'HOME': '/Users/cltbld', 13:49:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:46 INFO - 'LOGNAME': 'cltbld', 13:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:46 INFO - 'MOZ_NO_REMOTE': '1', 13:49:46 INFO - 'NO_EM_RESTART': '1', 13:49:46 INFO - 'PAGER': '/bin/cat', 13:49:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:46 INFO - 'PWD': '/builds/slave/test', 13:49:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:46 INFO - 'SHELL': '/bin/bash', 13:49:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GQ56AqYvf/Listeners', 13:49:46 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 13:49:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:46 INFO - 'USER': 'cltbld', 13:49:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:46 INFO - 'XPC_FLAGS': '0x0', 13:49:46 INFO - 'XPC_SERVICE_NAME': '0', 13:49:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:47 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-MlWkzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:47 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:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:47 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-MqMGu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:47 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:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:47 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-OUrHNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:47 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:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:47 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-ElJGbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:47 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:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:47 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-1fFiO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:47 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:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:47 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-lB2IFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:47 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:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:47 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-VV4JZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:47 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:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:47 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-4DWzlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:47 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:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:47 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-XaCK0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:47 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:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:47 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-yj0YMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:48 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:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:48 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-tOQdEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:48 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:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:48 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-Ngx44P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:48 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:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:48 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-ja0CIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:48 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:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:48 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-TfVLZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:48 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:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:48 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-_kwBM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:48 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:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:48 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-jyEmsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:48 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:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:48 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-JsODD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:48 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:49:48 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:49:48 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:49:48 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:49:48 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:49:48 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:49:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:49:48 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:49:48 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:49:48 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:49:48 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:49:48 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:49:48 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:49:51 INFO - Downloading blessings-1.6.tar.gz 13:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:49:51 INFO - Installing collected packages: blessings 13:49:51 INFO - Running setup.py install for blessings 13:49:51 INFO - Successfully installed blessings 13:49:51 INFO - Cleaning up... 13:49:51 INFO - Return code: 0 13:49:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:49:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:52 INFO - Reading from file tmpfile_stdout 13:49:52 INFO - Current package versions: 13:49:52 INFO - blessings == 1.6 13:49:52 INFO - blobuploader == 1.2.4 13:49:52 INFO - docopt == 0.6.1 13:49:52 INFO - functools32 == 3.2.3-2 13:49:52 INFO - jsonschema == 2.5.1 13:49:52 INFO - manifestparser == 1.1 13:49:52 INFO - mozInstall == 1.12 13:49:52 INFO - mozcrash == 1.0 13:49:52 INFO - mozdebug == 0.1 13:49:52 INFO - mozdevice == 0.49 13:49:52 INFO - mozfile == 1.2 13:49:52 INFO - mozhttpd == 0.7 13:49:52 INFO - mozinfo == 0.9 13:49:52 INFO - mozleak == 0.1 13:49:52 INFO - mozlog == 3.4 13:49:52 INFO - moznetwork == 0.27 13:49:52 INFO - mozprocess == 0.24 13:49:52 INFO - mozprofile == 0.28 13:49:52 INFO - mozrunner == 6.13 13:49:52 INFO - mozscreenshot == 0.1 13:49:52 INFO - mozsystemmonitor == 0.3 13:49:52 INFO - moztest == 0.8 13:49:52 INFO - mozversion == 1.4 13:49:52 INFO - psutil == 3.1.1 13:49:52 INFO - requests == 1.2.3 13:49:52 INFO - wsgiref == 0.1.2 13:49:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:52 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 0x10f218b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f21b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349446b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6d30>, '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 0x10ef1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efebbe8>, '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.kwvS82Deg4/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.3GQ56AqYvf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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:49:52 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:49:52 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:49:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwvS82Deg4/Render', 13:49:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:52 INFO - 'HOME': '/Users/cltbld', 13:49:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:52 INFO - 'LOGNAME': 'cltbld', 13:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:52 INFO - 'MOZ_NO_REMOTE': '1', 13:49:52 INFO - 'NO_EM_RESTART': '1', 13:49:52 INFO - 'PAGER': '/bin/cat', 13:49:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:52 INFO - 'PWD': '/builds/slave/test', 13:49:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:52 INFO - 'SHELL': '/bin/bash', 13:49:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GQ56AqYvf/Listeners', 13:49:52 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 13:49:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:52 INFO - 'USER': 'cltbld', 13:49:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:52 INFO - 'XPC_FLAGS': '0x0', 13:49:52 INFO - 'XPC_SERVICE_NAME': '0', 13:49:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:52 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:49:52 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:49:52 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:49:52 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:49:52 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:49:52 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:49:52 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:49:52 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:49:52 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:49:52 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:49:52 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:49:52 INFO - Cleaning up... 13:49:52 INFO - Return code: 0 13:49:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f218b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f21b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349446b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6d30>, '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 0x10ef1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efebbe8>, '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.kwvS82Deg4/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.3GQ56AqYvf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:49:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwvS82Deg4/Render', 13:49:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:52 INFO - 'HOME': '/Users/cltbld', 13:49:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:52 INFO - 'LOGNAME': 'cltbld', 13:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:52 INFO - 'MOZ_NO_REMOTE': '1', 13:49:52 INFO - 'NO_EM_RESTART': '1', 13:49:52 INFO - 'PAGER': '/bin/cat', 13:49:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:52 INFO - 'PWD': '/builds/slave/test', 13:49:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:52 INFO - 'SHELL': '/bin/bash', 13:49:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GQ56AqYvf/Listeners', 13:49:52 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 13:49:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:52 INFO - 'USER': 'cltbld', 13:49:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:52 INFO - 'XPC_FLAGS': '0x0', 13:49:52 INFO - 'XPC_SERVICE_NAME': '0', 13:49:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:49:52 INFO - Cleaning up... 13:49:52 INFO - Return code: 0 13:49:52 INFO - Running post-action listener: _resource_record_post_action 13:49:52 INFO - Running post-action listener: _start_resource_monitoring 13:49:52 INFO - Starting resource monitoring. 13:49:52 INFO - [mozharness: 2017-01-15 21:49:52.640971Z] Finished create-virtualenv step (success) 13:49:52 INFO - [mozharness: 2017-01-15 21:49:52.641944Z] Running install step. 13:49:52 INFO - Running pre-action listener: _resource_record_pre_action 13:49:52 INFO - Running main action method: install 13:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:52 INFO - Reading from file tmpfile_stdout 13:49:52 INFO - Detecting whether we're running mozinstall >=1.0... 13:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:49:53 INFO - Reading from file tmpfile_stdout 13:49:53 INFO - Output received: 13:49:53 INFO - Usage: mozinstall [options] installer 13:49:53 INFO - Options: 13:49:53 INFO - -h, --help show this help message and exit 13:49:53 INFO - -d DEST, --destination=DEST 13:49:53 INFO - Directory to install application into. [default: 13:49:53 INFO - "/builds/slave/test"] 13:49:53 INFO - --app=APP Application being installed. [default: firefox] 13:49:53 INFO - mkdir: /builds/slave/test/build/application 13:49:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:50:15 INFO - Reading from file tmpfile_stdout 13:50:15 INFO - Output received: 13:50:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:50:15 INFO - Running post-action listener: _resource_record_post_action 13:50:15 INFO - [mozharness: 2017-01-15 21:50:15.567056Z] Finished install step (success) 13:50:15 INFO - [mozharness: 2017-01-15 21:50:15.567199Z] Running run-tests step. 13:50:15 INFO - Running pre-action listener: _resource_record_pre_action 13:50:15 INFO - Running main action method: run_tests 13:50:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:50:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:50:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:50:15 INFO - 2017-01-15 13:50:15.581 screenresolution[1676:16128] starting screenresolution argv=screenresolution get 13:50:15 INFO - 2017-01-15 13:50:15.584 screenresolution[1676:16128] Display 0: 1600x1200x32@60 13:50:15 INFO - 2017-01-15 13:50:15.590 screenresolution[1677:16130] starting screenresolution argv=screenresolution list 13:50:15 INFO - Available Modes on Display 0 13:50:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:50:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:50:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:50:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:50:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:50:15 INFO - Intel Iris: 13:50:15 INFO - Chipset Model: Intel Iris 13:50:15 INFO - Type: GPU 13:50:15 INFO - Bus: Built-In 13:50:15 INFO - VRAM (Dynamic, Max): 1536 MB 13:50:15 INFO - Vendor: Intel (0x8086) 13:50:15 INFO - Device ID: 0x0a2e 13:50:15 INFO - Revision ID: 0x0009 13:50:15 INFO - Displays: 13:50:15 INFO - Display: 13:50:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:50:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:50:15 INFO - Display Serial Number: 1600x1200 60 13:50:15 INFO - Main Display: Yes 13:50:15 INFO - Mirror: Off 13:50:15 INFO - Online: Yes 13:50:15 INFO - Rotation: Supported 13:50:15 INFO - Return code: 0 13:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:50:15 INFO - Python 2.7.3 13:50:15 INFO - Return code: 0 13:50:15 INFO - grabbing minidump binary from tooltool 13:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:15 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 0x10eff6d30>, '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 0x10ef1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efebbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:50:15 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:50:15 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:50:15 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:50:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:50:15 INFO - Return code: 0 13:50:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:50:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:50:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:50:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:50:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0301', '--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:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0301 --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:50:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwvS82Deg4/Render', 13:50:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:15 INFO - 'HOME': '/Users/cltbld', 13:50:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:15 INFO - 'LOGNAME': 'cltbld', 13:50:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:50:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:15 INFO - 'MOZ_NO_REMOTE': '1', 13:50:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:50:15 INFO - 'NO_EM_RESTART': '1', 13:50:15 INFO - 'PAGER': '/bin/cat', 13:50:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:15 INFO - 'PWD': '/builds/slave/test', 13:50:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:50:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:15 INFO - 'SHELL': '/bin/bash', 13:50:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GQ56AqYvf/Listeners', 13:50:15 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 13:50:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:15 INFO - 'USER': 'cltbld', 13:50:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:15 INFO - 'XPC_FLAGS': '0x0', 13:50:15 INFO - 'XPC_SERVICE_NAME': '0', 13:50:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0301', '--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:50:16 INFO - mozversion application_buildid: 20170115123323 13:50:16 INFO - mozversion application_changeset: 829f16159b89b921eb81e0f26954ef54ae55034b 13:50:16 INFO - mozversion application_display_name: Nightly 13:50:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:50:16 INFO - mozversion application_name: Firefox 13:50:16 INFO - mozversion application_remotingname: firefox 13:50:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:50:16 INFO - mozversion application_vendor: Mozilla 13:50:16 INFO - mozversion application_version: 53.0a1 13:50:16 INFO - mozversion platform_buildid: 20170115123323 13:50:16 INFO - mozversion platform_changeset: 829f16159b89b921eb81e0f26954ef54ae55034b 13:50:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:50:16 INFO - mozversion platform_version: 53.0a1 13:50:16 INFO - using testdate: 1484517016 13:50:16 INFO - actual date: 1484517016 13:50:16 INFO - starting webserver on 'localhost:49243' 13:50:16 INFO - SUITE-START | Running 2 tests 13:50:16 INFO - TEST-START | dromaeo_css 13:50:16 INFO - operating with platform_type : mac_ 13:50:16 INFO - Initialising browser for dromaeo_css test... 13:50:16 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpsc2U3m/profile http://localhost:49243/getInfo.html) 13:50:18 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 13:50:18 INFO - PROCESS | 1687 | colorDepth:24 13:50:18 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 13:50:18 INFO - PROCESS | 1687 | __metrics 13:50:18 INFO - PROCESS | 1687 | 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:50:18 INFO - PROCESS | 1687 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:50:19 INFO - TEST-INFO | 1687: exit 0 13:50:19 INFO - Browser initialized. 13:50:19 INFO - Running cycle 1/1 for dromaeo_css test... 13:50:19 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpsc2U3m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:50:31 INFO - PROCESS | 1690 | RSS: Main: 227049472 13:50:31 INFO - PROCESS | 1690 | 13:53:35 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 13:53:37 INFO - PROCESS | 1690 | RSS: Main: 343764992 13:53:37 INFO - PROCESS | 1690 | 13:55:21 INFO - PROCESS | 1690 | ************************* 13:55:21 INFO - PROCESS | 1690 | A coding exception was thrown and uncaught in a Task. 13:55:21 INFO - PROCESS | 1690 | 13:55:21 ERROR - PROCESS | 1690 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:55:21 INFO - PROCESS | 1690 | Full stack: 13:55:21 INFO - PROCESS | 1690 | ************************* 13:56:40 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 13:56:40 INFO - PROCESS | 1690 | RSS: Main: 367595520 13:56:40 INFO - PROCESS | 1690 | 13:59:43 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 13:59:44 INFO - PROCESS | 1690 | RSS: Main: 359628800 13:59:44 INFO - PROCESS | 1690 | 14:02:46 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 14:02:47 INFO - PROCESS | 1690 | RSS: Main: 332242944 14:02:47 INFO - PROCESS | 1690 | 14:05:50 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 14:05:51 INFO - PROCESS | 1690 | RSS: Main: 326471680 14:05:51 INFO - PROCESS | 1690 | 14:08:54 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 14:08:54 INFO - PROCESS | 1690 | RSS: Main: 475955200 14:08:54 INFO - PROCESS | 1690 | 14:08:54 INFO - PROCESS | 1690 | __start_tp_report 14:08:54 INFO - PROCESS | 1690 | _x_x_mozilla_page_load 14:08:54 INFO - PROCESS | 1690 | _x_x_mozilla_page_load_details 14:08:54 INFO - PROCESS | 1690 | |i|pagename|runs| 14:08:54 INFO - PROCESS | 1690 | |0;dojo.html;3324.3517514084747;3332.5501057357255;3355.328934213158;3355.496675498675;3406.199543107369;4905.681130726509;5159.871003224921;5659.830205093848;5729.140628905661;5732.885342293157;5698.0883058710615;5709.400512946143;5807.41925807419;5809.593328467009;5849.034909239981;4290.97854510727;5125.179971204608;5139.614528910328;5173.172292433212;5205.063088644042;5197.610179236553;5250.396204436482;5285.814996475124;5302.2841916341185;5331.493508116722;5096.541311282002;5253.579713622901;5262.473752624745;5290;5297.788088476456;5130.769115389817;5182.404023537304;5183.688978661293;5185.688858668492;5188.507091826271;5065.366829146356;5144.3312369392115;5156.819511317123;5158.226266060084;5168.715720635363;4576.427946506687;5635.63368381058;5641.238432811559;5642.830715078554;5645.745941432645;6178;6182.412670796267;6191.566590338678;6239.906401403982;6265.5614107012525;6236.812895613139;6283.717232724538;6290.21372328459;6296.559240853142;6311;5770.307563092456;5842.883142337215;5852.795152169696;5871.236739223959;5897.705114744245;5437.401885792559;5521.1442226454965;6112.419320164578;6287.685615719196;6292.465140463112;6012.879742405127;6219.284782250099;6226.283977342573;6230.439260466489;6235.064740288993;6232.096346029891;6292.182016337938;6301.747930082837;6303.054541818764;6312.179416675803;5964.552658550626;5966.940330596725;6131.816045518642;6149.661768602769;6165.506759459233;6049.0926361046195;6059.575829691968;6064.06007068905;6070.969645151746;6104.20645316106;4819.2530157825595;4825.662203645781;4830.106430310334;4839.370881785346;4875.731834749052;4327.697061205686;4338.717983331137;4385.101054283864;4453.087117140978;4454.799534020977;5868.09044598088;5875.41245875409;5907.586468947133;5932.584719069624;5974.701264936736;5399.352077750616;6033.939660603338;6178.196834411588;6201.782937597162;6250.374962503804;5644.520215781622;5893.14549390336;5922.615030023121;5924.851878703067;5936.5250779937505;5383.353997520323;5402.216678581583;5429.782808687687;5471.987682278791;5486.615936884459;6383.840403989844;6413.935860641427;6414.390632889868;6417.1657684500715;6419.2296924369375;6219.813405597839;6226.3151053385;6232.127502149612;6236.656983865931;6236.844078898064;6127.556056270746;6169.598976066542;6187.969060154671;6216.129741836237;6332.145160403286;6122.764110201883;6144.969275153596;6145.002874065857;6175.320714721287;6177.722002509808;6136.785212517719;6154.353792851686;6155.661438620739;6167.290761562478;6192.349803270592;6049.697515124314;6061.787837425669;6096.481799046954;6103.115048318058;6150.538709596709;5050.898982020412;6091.113275426838;6124.74712746768;6149.831532008904;6162.168107305456;5765.682887441063;6107.977837958671;6123.30323506545;6124.808163753285;6133.1510485532735;4430.291153415567;4506.7070640408265;5710.143478478095;5892.970535147469;6150.077488376779;6061.848453788691;6070.939290607214;6082.118092876596;6082.300535438481;6110.7250173741395 14:08:54 INFO - PROCESS | 1690 | |1;ext.html;443.7670223132855;471.75704512176236;495.4525249599193;519.874471768621;523.0010679601961;35317.82341088294;41538.7923060385;41553.961150971205;41582.16835663285;41631.583684163226;42540;42892.142157156835;42923.49767758129;43028;43049.923751906215;8385.958070209641;9282.582283797228;9435.811283774321;9496;9498;8333.416660833744;11127.221094523387;11376.431178441086;11387.829182562267;11541.769164616702;9576.712698619052;11265.098792096613;11318.603848865292;11321.490532925996;11330.830037549444;8387.580620968989;8608.01007884095;11247.381394023325;11294.20940534163;11313.09495240383;10868.239223254375;11168.66494005181;11206.383648899307;11286.26639268453;11323.603673871376;39184.41223381623;39541.20917581632;39652;39694.80915572537;39722.80138599288;4029.979850100731;4063.6952228582677;4081.265372232997;4121.381792731085;4221.261279276115;30171.44456159446;30182.84908575465;30209.395812083854;30862.845685771426;31106.377872442423;3106.2079169811777;3110.5334199869976;3133.310671652233;3138.184072141237;3217.211783113129;448937;456617;457972;458250;460899;51494.485055149715;61757;63564;63658.363416365246;63785.72428551403;66139;67008;67051.32948670548;67116.328836711;67259.66370168216;15952.361905523881;16516.339346426008;16533.669326613643;16553;16658.6668266634;11435.028022618171;11715.238509497025;12395.75208495825;12438.81341779874;12641.11512194156;18105.732598718227;18345.54136146607;18435.907820460812;18574.349897753513;18590.977496237567;5799.855003624859;6558.508111891627;6613.338666133348;6633.374823168355;6792;762.9771106866802;867.9566021698889;879.9396726944017;894.2532984957503;914.1407077347405;29758;29869;29951.850240748656;30363;30570.847145764128;1069.385103565453;1080.8432777247256;1105.745678493951;1117.5976648406568;1159.6347150647518;13401.664958375924;15516.612084697746;15587.298571564306;15599.53201403937;15893.523194304189;548538;839878;861569;861590;862389;51076.23385649218;51631;51653.48346516487;51749.2237616436;51841.2223816643;1406.2054938959454;1411.6682579593787;1449.5578848451323;1451.5935538049364;1451.9491817786327;27940.441191175654;27959.161225163276;28023.859880700467;28744.281392965342;28817.7118228815;45262.86842828824;45522;45658;45761.313580296985;45832.312515312966;442384;443792;446807;447798;449516;22379.77620223842;22995.88502057479;24347.634785477876;24656.753432466165;24681.259562213163;40807.59192408038;43202.567974321115;43228;43986.56013439953;44769.88075298144;32181.03456896297;35159.82420087883;35222.64777352194;36259.818700906326;36392;34659.82670086633;35208;36060;36174.09564760902;36535.45196822103;34334.82832585921;34489.31021379609;34740.826295868355;35032;35323;29853.402931941673;30990.38019239648;31382.372352553277;31425;31480.84259578779;23194.1882034128;23295.41761455977;23559.882200588887;23880.40298992539;24044.639330409707 14:08:54 INFO - PROCESS | 1690 | |2;jquery.html;339.49076385421876;356.8572570971611;366.7799320407754;368.7179307829511;382.9253295607356;15393.615159621015;15581.766273505893;16353.754693679604;20534.281300154496;21333.35999920005;21373.786262137375;21415;22140.88929555354;22148.557028859414;22258;5761.078227483604;5829.743957884666;5888.970555147218;6019.367966363535;6022.247219097613;5819.709014549277;5875.970620146893;5914.585978981473;5928.851778705523;5937.67342796146;4205.810738516774;4414.492333381654;6331.398517140888;6619.4704423646235;6654.268030516663;5651;6336.809895703136;6497.9350206498275;6637;6645.966770166118;5773.162891380768;5773.913391299134;5779;5786.739596718157;5793.449622285876;26237.606435903475;27202;27265.318367040785;27373.863130684418;27608.447831043468;2669.919902402931;2743.7804975601903;2744.9588256176175;2747.5191841427672;2761.4811853480705;15430.691386172326;15900.76148857768;16154.273057712431;16321.59196020097;16573.17695053543;1841.7974022857475;1847.104154485087;1847.29802674984;1858.9721154182698;1910.436421255733;93270.44588395662;98322.016779832;123385.38307308496;124539.5092098162;135741.3212933929;11141.164412669083;11232.943835280772;11316.660500185008;11390.430478476042;11577.594784182682;14270.429182832571;14315.856841431661;14819.925900370428;14859.777103343458;14893.925530372278;8563;8849.51327676984;8863.911360886437;8976.147266009719;8988.955055224682;7117.857642847218;8799.29605631548;8839.646414143492;8990;9036.593353299117;7181.748638797617;7334.816629584197;7348.5958272294465;7357.448191385561;7384.372328352043;1722.3455087067084;1905.5998240369677;1941.1847024249848;1943.154727693458;1954.1206457094365;1030.5620111452752;1048.5438834107188;1062.2086545523634;1088.88022317545;1108.152263518409;19021.239150434103;20792;21052.894735526224;22763.544729105324;22996.310110696704;991.9256055795844;1028.9453310356944;1065.3341661461586;1098.3849044535086;1101.2566517600587;10918.50866710984;11501.482433290523;11757.823632645517;11900.285982841056;11949.76100478003;557804;634915.82542087;703725;706119;746850;103984;117139;123621.29136125931;131750;135861;985.6451677396132;1002.7966440271703;1059.5126241928645;1062.8033813744482;1073.291627525845;16036.599085022968;20597.176112955312;20600.690989634866;20728.48178795542;20742;57740;58087.70956145192;58689;60521.39478605158;60651.69674151601;70144.29855701582;81738;83922.32155356981;85342.57328713317;87851;7151.141862976476;7347.666679950576;7457.2542745724995;7571.3564347031115;7710.421718371257;12752.553660621834;13222.140560863512;13248.873845723221;13706.314684265548;13776.448942042207;9797.65708200238;9941.353812002197;10952.069074128469;11520.308781473139;11747.412629368668;11117.666470005914;11439.542418303176;11444.713882153013;11523.711907202387;11735.354555499189;11090.65049779188;11372.943135284271;11588.6523404298;11919.106067045179;12043.036557075238;6406.711697973509;8332.291755200877;8408.2432581068;8476.23713865755;8544.57277136153;10427.843582346422;10788.784224315314;11350.54597816078;11871.821922670993;11941.343226122646 14:08:54 INFO - PROCESS | 1690 | |3;mootools.html;1411.054593422407;1442.6032840968733;1450.1226757811523;1469.0818238600868;1471;8140.267375936164;8528.317734581235;8544.017437994633;8553.315734741222;8581.785455363603;7408.629568521579;7737.767866963986;7739.6904123834975;7833.725819596315;7839.882401763978;2091.3098677436487;2257.503349263168;2335.8948847301826;2341.9297421077395;2350.905963761456;2329.091654254842;2330.067972810872;2344.0272287000876;2365.82256330775;2379.5359904818565;2266.46738016566;2300.6894069300597;2306.642470417088;2312.364099872532;2312.722473303206;2012.7886571909885;2289.919852805152;2297.666838308436;2314.5139520700673;2318.07277089164;2278.624027035537;2317.5480781247666;2340.180936672168;2350.670906073151;2353.97646023541;8341.332693384515;8449.155084491564;8454.28138608219;8456.57717114148;8461.407701460901;5061.367329083864;5219.42586315505;5224.686518808883;5233.502817232356;5237.895242095175;3327.4010678077934;3529.364714351416;3533.9116522086897;3549.733769967237;3611.674949254553;1133.8185890257603;1137.1528211482498;1162.9360385178811;1200.8619008813923;1262.8926541243914;10698.51856666452;10713.839292410543;10717.410542420164;10734.892651073467;10740.14078873696;4578.519255478193;4599.402077729874;4610.76946152691;4642.303654451859;4703.764811759398;9423.811523769624;9494.05059494045;9506.667266645634;9515.476648784244;9524.714258572254;5240.0567897778765;5248.1602943529615;5256.290400795843;5260.894782104337;5262.368515778131;4643.8374656886845;4745.454272758608;4771.642126840501;4844.588210002189;4876.390451193601;3363.5963684358035;3440.7419443541335;3458.654134586521;3607.7113830893463;3738.9065273367837;994.8060128274917;1147.833564133196;1161.6573110932295;1163.040491594438;1166.8249762535688;768.9423293253028;769.4190885881236;780.0717146595533;790.2097902097902;792.9603519823986;5451.536619387317;5544.77820887168;5559.444055594408;5640.661560306313;5648.915266271009;943.2878176976476;944.5607792376578;954.5322791831952;997.4015590645699;1030.3199888073834;3590.551181102362;3714.795686237229;3737.7383583149463;3818.217265460574;3824.8661296854475;9683.757906052406;9746.415215086976;9771.071748183911;9897.703068907944;9989.500524973722;7512.39900807934;9633.373830700983;9854.458004809805;9882.357646752938;10009.249306302056;7764.262395072459;7911.28798408146;7946.841063178704;7956.164602716747;7965.721199757981;5263.34208223972;5447.0467668157125;5453.8457309363375;5796.782675638163;5898.262717160355;9138.08619138081;9301.581428835854;9303.953480232556;9313.906860931575;9314.161725444743;8932.46405215689;9138.68014619485;9362;9362.438253704799;9405.24758019343;7110.928890711233;7162.534435261691;7179.748708795167;7219.963900180465;7272.018277532466;7125.572465652078;7390.482666213314;7401.925980740339;7582.090149182133;7804;6889.138857642794;7003.229644739176;7103.112110986127;7123.857522849617;7210.783676489714;6997.650117494003;7015.473839462163;7076.25699301566;7185.820354491179;7201.279872012757;5244.685318880879;5329.946700532945;6163.106349579376;6385.648789316632;6400.679966001774;4418.823247070081;4853.6602437829015;4939.975300123477;4941.382327209099;5061.114304996538;4275.850345238026;4433.623142032963;4898.485659005753;5013.671377085003;5069.69581825077 14:08:54 INFO - PROCESS | 1690 | |4;prototype.html;349.43915016398677;355.6887723242163;360.45391232283094;372.6552938531861;373.41374042752886;4839.8790030249265;5300.337457817773;5346.930613877231;5371.382291036532;5398.433164517728;4336.392904993303;4908.828191013306;5098.413682426522;5104.821331253407;5237.764300606473;3413.692767650911;3457.82710864457;4096.262672718909;4128.669706423494;4129.359949207877;3534.6995505381947;4034.69739769517;4094.263032654121;4100.416737455399;4149.585041495857;3471.722262219029;3714.034351068728;3954.8220330085214;4076.3070278052655;4102.220578090169;3514.3291098764867;3935.9963209381426;3977.448794969964;3977.980110099431;3982.183652351261;2938.7942844000927;3397.3545026444895;3435.003848883821;3445.242046749711;3461.2212252243294;4515.2324104902245;4805.351277577517;5119.385673719177;5132.435432102503;5203.349581302337;3822.617738226183;4161.9375709364385;4562.22442184826;4574.72551646899;4577.9942550268515;5485.835424937259;5500.7524661390335;5518.255035570187;5531.0873705838485;5535.03136951036;3637.7453578249533;3757.868474603376;3785.867494637702;3807.162424266657;3817.751846129993;4861.562459378708;5061.367329083864;5538.833834984957;5791.913121303184;5914.319853216892;3831.1762970961377;3832.7317087803585;3844.6732027777393;3847.8845634630447;3855.9036024099623;3406.3527929693278;3460.117669994135;3476.66971637694;3783.710854932781;3905.7656540607654;4186.28833098374;4538.478075021349;4547.636189104864;4557.612602928722;4565.908681826345;4599.33309670096;4927.408710954636;5308.840734777963;5381.461853814587;5618.775248989995;1258.5783762439685;1258.9811152832715;1259.5843371687322;1266.835311409511;1279.2708156350977;799.8641928461599;825.0676735289085;827.8120896513523;890.3455959869491;967.9612815487443;4462.359146487616;4904.7438178438315;4928.433230178575;4931.926021109686;4955.603551715854;4498.617617502549;4523.095380923828;4767;4918.926216106761;5453.927507547186;4287.098740146452;4357.564243575617;4682.344471773954;4687.742174180385;4889.435380678149;2769.612254284402;2795.720427957188;2829.7311755383616;2856.486292063013;2878.1797187801376;4769.833055843029;4986.7114281717695;5161.922571161435;5500.697461639568;5523.447655234444;4635.327877457749;4715.622750179978;5125.207930584915;5137.717425541631;5211.973940130275;5038.924416133761;5263.394709608444;5521.542913403578;5521.889562208814;5565.41563135873;4434.246178149658;4632.768361581975;5127.948720512747;5332.626716129834;5365.839024829262;4794.928076078932;4835.178019736723;4947.925781113358;5020.899582008413;5142.808610982038;4565.406497155349;4793.209120495079;4873.537013983666;5291.5340452004;5520.420355862577;3322.7539672622765;3366.444536651425;3531.404417752898;3870.4000879863665;3927.2930872443235;4949.5151454562765;5015.648904576645;5258.474152584711;5329.520343169133;5387.7844886205685;4412.624926881251;5055.646104772778;5195.272661827272;5209.47905209476;5220;4636.142313671981;5116.411612664591;5137.717425541631;5143.562797162133;5165.063101336998;4552.770751897036;4633.536646335474;5394;5418.647787893774;5459.508644222039;4547.636189104797;5262.394824595068;5397.085573790109;5452.318460192476;5631.549476041989;4345.847895323648;4602.953970460252;5380.439672494933;5423.728813559227;5429.511343979061 14:08:54 INFO - PROCESS | 1690 | |5;yui.html;705.537872693386;731.6085894046686;762.0093877958656;796.860489500015;816.5223344343559;14834.629134271649;15858.207089645515;15863.524094277162;15903.68192636148;15919.840801591981;14320.212388318638;14453.92773036136;14477.058991165566;14477.058991165593;14487.710245795079;669.3875104279579;687.779910428663;689.672405607335;848.5587494502855;865.5412631305387;832.4589017138878;851.2636569367514;853.3812985585463;866.0213958227195;867.453504292295;900.545224661545;904.0688091266006;905.6060613633091;905.868649045888;906.4742449379344;712.0671919785098;767.48578452437;896.1576118448637;899.5861903524386;900.3967341880956;539.2773683264405;642.7493277621685;661.2263651527724;661.3882159002903;664.4385494257344;15038.398464061424;15071.171085590287;15078.095314281069;15091.698166036727;15108.39566417342;13452.596422107352;13464.596062118153;13506.98697597684;13512.729745405135;13540;12465.252084874937;12507.874921250763;12530.498780048787;12553.309567973758;12640.74718505634;4202.052766956718;4324.589164029412;4394.978025109886;4443.333499974998;4501.504834468205;86237;101124.49437752838;104497.47751261195;104634;107154.46422767836;10305.639302624371;10733;10793.784124317626;11050.281731687415;11151.38667373286;21710.674339884914;21814.236501722364;21918.342449726533;22133;22136.003879825446;7494.85010299791;7519.210482899326;7525.2098529654695;7586.924130758732;7776.611169441505;4138.6482149017065;4235.618794308527;4274.337477690963;4311.137772445523;4394.868153955386;3436.862525499002;3450.413429716954;3553.3959226931483;3555.7333200009584;3566.625504322009;535.2399592578548;620.3920158244945;620.8137558732362;629.8771739510752;632.4655665962255;586.2642383808293;653.098723761216;658.9472842172614;661.9702113404908;671.4863129705778;8839.469631821983;9081.091890810865;9176.183722724047;9615.375000625078;9682.467464289532;623.4077626255075;626.6584711332334;660.2638058564762;664.4119953840789;682.3619915379137;4806.351142595775;4843.539863712942;4847.394075740533;4867.294242334841;4895.094407534618;87246;103648;104569.47715261375;105625;107325.46337268264;74719.62640186764;74929;75748;76335;82184;71443.64278178576;72512.54974900578;72792.9081063795;74023.25976740272;75173.09990051521;9735.951320243354;10460;10598.47007649599;10677.14582833356;10865.293755905841;48177;49129.771755706395;49637.75181124071;49864;50178;62391;62546;63658;64252.71494570176;65514.689706204656;13072.738545228853;13084.28036458004;13092.738145237232;13284.937205023381;13305.002124840483;14527.491537796126;14539.709205816036;14738.55784326472;15151.848481515484;15423.383064677737;13738;13895.861041389457;13901.652458688613;14018.369173387426;14355.784663230268;13636.93181534086;13767.655808604864;13797.51708690191;13805.723885522033;13854.307284635526;13364.331783410596;13369.799453008018;13616.38726257301;13643.113197642122;14164.291785410482;10768.300060496043;11080.279781814157;11375.26060806045;11518.251313664585;11649.825252621047;10845.403502807421;10927.235093543375;10930.180236482136;11007;11129.109671226444 14:08:54 INFO - PROCESS | 1690 | __end_tp_report 14:08:54 INFO - PROCESS | 1690 | __start_cc_report 14:08:54 INFO - PROCESS | 1690 | _x_x_mozilla_cycle_collect,1499 14:08:54 INFO - PROCESS | 1690 | __end_cc_report 14:08:54 INFO - PROCESS | 1690 | __startTimestamp1484518134833__endTimestamp 14:08:54 INFO - PROCESS | 1690 | 14:08:54 INFO - PROCESS | 1690 | ------- Summary: start ------- 14:08:54 INFO - PROCESS | 1690 | Number of tests: 6 14:08:54 INFO - PROCESS | 1690 | 14:08:54 INFO - PROCESS | 1690 | [#0] dojo.html Cycles:165 Average:5690.69 Median:5936.53 stddev:673.56 (11.3%) stddev-sans-first:649.54 14:08:54 INFO - PROCESS | 1690 | Values: 3324.4 3332.6 3355.3 3355.5 3406.2 4905.7 5159.9 5659.8 5729.1 5732.9 5698.1 5709.4 5807.4 5809.6 5849.0 4291.0 5125.2 5139.6 5173.2 5205.1 5197.6 5250.4 5285.8 5302.3 5331.5 5096.5 5253.6 5262.5 5290.0 5297.8 5130.8 5182.4 5183.7 5185.7 5188.5 5065.4 5144.3 5156.8 5158.2 5168.7 4576.4 5635.6 5641.2 5642.8 5645.7 6178.0 6182.4 6191.6 6239.9 6265.6 6236.8 6283.7 6290.2 6296.6 6311.0 5770.3 5842.9 5852.8 5871.2 5897.7 5437.4 5521.1 6112.4 6287.7 6292.5 6012.9 6219.3 6226.3 6230.4 6235.1 6232.1 6292.2 6301.7 6303.1 6312.2 5964.6 5966.9 6131.8 6149.7 6165.5 6049.1 6059.6 6064.1 6071.0 6104.2 4819.3 4825.7 4830.1 4839.4 4875.7 4327.7 4338.7 4385.1 4453.1 4454.8 5868.1 5875.4 5907.6 5932.6 5974.7 5399.4 6033.9 6178.2 6201.8 6250.4 5644.5 5893.1 5922.6 5924.9 5936.5 5383.4 5402.2 5429.8 5472.0 5486.6 6383.8 6413.9 6414.4 6417.2 6419.2 6219.8 6226.3 6232.1 6236.7 6236.8 6127.6 6169.6 6188.0 6216.1 6332.1 6122.8 6145.0 6145.0 6175.3 6177.7 6136.8 6154.4 6155.7 6167.3 6192.3 6049.7 6061.8 6096.5 6103.1 6150.5 5050.9 6091.1 6124.7 6149.8 6162.2 5765.7 6108.0 6123.3 6124.8 6133.2 4430.3 4506.7 5710.1 5893.0 6150.1 6061.8 6070.9 6082.1 6082.3 6110.7 14:08:54 INFO - PROCESS | 1690 | 14:08:54 INFO - PROCESS | 1690 | [#1] ext.html Cycles:180 Average:69258.04 Median:35320.41 stddev:159570.96 (451.8%) stddev-sans-first:159934.96 14:08:54 INFO - PROCESS | 1690 | Values: 443.8 471.8 495.5 519.9 523.0 35317.8 41538.8 41554.0 41582.2 41631.6 42540.0 42892.1 42923.5 43028.0 43049.9 8386.0 9282.6 9435.8 9496.0 9498.0 8333.4 11127.2 11376.4 11387.8 11541.8 9576.7 11265.1 11318.6 11321.5 11330.8 8387.6 8608.0 11247.4 11294.2 11313.1 10868.2 11168.7 11206.4 11286.3 11323.6 39184.4 39541.2 39652.0 39694.8 39722.8 4030.0 4063.7 4081.3 4121.4 4221.3 30171.4 30182.8 30209.4 30862.8 31106.4 3106.2 3110.5 3133.3 3138.2 3217.2 448937.0 456617.0 457972.0 458250.0 460899.0 51494.5 61757.0 63564.0 63658.4 63785.7 66139.0 67008.0 67051.3 67116.3 67259.7 15952.4 16516.3 16533.7 16553.0 16658.7 11435.0 11715.2 12395.8 12438.8 12641.1 18105.7 18345.5 18435.9 18574.3 18591.0 5799.9 6558.5 6613.3 6633.4 6792.0 763.0 868.0 879.9 894.3 914.1 29758.0 29869.0 29951.9 30363.0 30570.8 1069.4 1080.8 1105.7 1117.6 1159.6 13401.7 15516.6 15587.3 15599.5 15893.5 548538.0 839878.0 861569.0 861590.0 862389.0 51076.2 51631.0 51653.5 51749.2 51841.2 1406.2 1411.7 1449.6 1451.6 1451.9 27940.4 27959.2 28023.9 28744.3 28817.7 45262.9 45522.0 45658.0 45761.3 45832.3 442384.0 443792.0 446807.0 447798.0 449516.0 22379.8 22995.9 24347.6 24656.8 24681.3 40807.6 43202.6 43228.0 43986.6 44769.9 32181.0 35159.8 35222.6 36259.8 36392.0 34659.8 35208.0 36060.0 36174.1 36535.5 34334.8 34489.3 34740.8 35032.0 35323.0 29853.4 30990.4 31382.4 31425.0 31480.8 23194.2 23295.4 23559.9 23880.4 24044.6 14:08:54 INFO - PROCESS | 1690 | 14:08:54 INFO - PROCESS | 1690 | [#2] jquery.html Cycles:180 Average:37448.97 Median:22203.28 stddev:111601.36 (502.6%) stddev-sans-first:111879.65 14:08:54 INFO - PROCESS | 1690 | Values: 339.5 356.9 366.8 368.7 382.9 15393.6 15581.8 16353.8 20534.3 21333.4 21373.8 21415.0 22140.9 22148.6 22258.0 5761.1 5829.7 5889.0 6019.4 6022.2 5819.7 5876.0 5914.6 5928.9 5937.7 4205.8 4414.5 6331.4 6619.5 6654.3 5651.0 6336.8 6497.9 6637.0 6646.0 5773.2 5773.9 5779.0 5786.7 5793.4 26237.6 27202.0 27265.3 27373.9 27608.4 2669.9 2743.8 2745.0 2747.5 2761.5 15430.7 15900.8 16154.3 16321.6 16573.2 1841.8 1847.1 1847.3 1859.0 1910.4 93270.4 98322.0 123385.4 124539.5 135741.3 11141.2 11232.9 11316.7 11390.4 11577.6 14270.4 14315.9 14819.9 14859.8 14893.9 8563.0 8849.5 8863.9 8976.1 8989.0 7117.9 8799.3 8839.6 8990.0 9036.6 7181.7 7334.8 7348.6 7357.4 7384.4 1722.3 1905.6 1941.2 1943.2 1954.1 1030.6 1048.5 1062.2 1088.9 1108.2 19021.2 20792.0 21052.9 22763.5 22996.3 991.9 1028.9 1065.3 1098.4 1101.3 10918.5 11501.5 11757.8 11900.3 11949.8 557804.0 634915.8 703725.0 706119.0 746850.0 103984.0 117139.0 123621.3 131750.0 135861.0 985.6 1002.8 1059.5 1062.8 1073.3 16036.6 20597.2 20600.7 20728.5 20742.0 57740.0 58087.7 58689.0 60521.4 60651.7 70144.3 81738.0 83922.3 85342.6 87851.0 7151.1 7347.7 7457.3 7571.4 7710.4 12752.6 13222.1 13248.9 13706.3 13776.4 9797.7 9941.4 10952.1 11520.3 11747.4 11117.7 11439.5 11444.7 11523.7 11735.4 11090.7 11372.9 11588.7 11919.1 12043.0 6406.7 8332.3 8408.2 8476.2 8544.6 10427.8 10788.8 11350.5 11871.8 11941.3 14:08:54 INFO - PROCESS | 1690 | 14:08:54 INFO - PROCESS | 1690 | [#3] mootools.html Cycles:180 Average:5375.46 Median:5261.63 stddev:2932.06 (55.7%) stddev-sans-first:2925.15 14:08:54 INFO - PROCESS | 1690 | Values: 1411.1 1442.6 1450.1 1469.1 1471.0 8140.3 8528.3 8544.0 8553.3 8581.8 7408.6 7737.8 7739.7 7833.7 7839.9 2091.3 2257.5 2335.9 2341.9 2350.9 2329.1 2330.1 2344.0 2365.8 2379.5 2266.5 2300.7 2306.6 2312.4 2312.7 2012.8 2289.9 2297.7 2314.5 2318.1 2278.6 2317.5 2340.2 2350.7 2354.0 8341.3 8449.2 8454.3 8456.6 8461.4 5061.4 5219.4 5224.7 5233.5 5237.9 3327.4 3529.4 3533.9 3549.7 3611.7 1133.8 1137.2 1162.9 1200.9 1262.9 10698.5 10713.8 10717.4 10734.9 10740.1 4578.5 4599.4 4610.8 4642.3 4703.8 9423.8 9494.1 9506.7 9515.5 9524.7 5240.1 5248.2 5256.3 5260.9 5262.4 4643.8 4745.5 4771.6 4844.6 4876.4 3363.6 3440.7 3458.7 3607.7 3738.9 994.8 1147.8 1161.7 1163.0 1166.8 768.9 769.4 780.1 790.2 793.0 5451.5 5544.8 5559.4 5640.7 5648.9 943.3 944.6 954.5 997.4 1030.3 3590.6 3714.8 3737.7 3818.2 3824.9 9683.8 9746.4 9771.1 9897.7 9989.5 7512.4 9633.4 9854.5 9882.4 10009.2 7764.3 7911.3 7946.8 7956.2 7965.7 5263.3 5447.0 5453.8 5796.8 5898.3 9138.1 9301.6 9304.0 9313.9 9314.2 8932.5 9138.7 9362.0 9362.4 9405.2 7110.9 7162.5 7179.7 7220.0 7272.0 7125.6 7390.5 7401.9 7582.1 7804.0 6889.1 7003.2 7103.1 7123.9 7210.8 6997.7 7015.5 7076.3 7185.8 7201.3 5244.7 5329.9 6163.1 6385.6 6400.7 4418.8 4853.7 4940.0 4941.4 5061.1 4275.9 4433.6 4898.5 5013.7 5069.7 14:08:54 INFO - PROCESS | 1690 | 14:08:54 INFO - PROCESS | 1690 | [#4] prototype.html Cycles:180 Average:4290.73 Median:4701.68 stddev:1270.98 (27.0%) stddev-sans-first:1239.65 14:08:54 INFO - PROCESS | 1690 | Values: 349.4 355.7 360.5 372.7 373.4 4839.9 5300.3 5346.9 5371.4 5398.4 4336.4 4908.8 5098.4 5104.8 5237.8 3413.7 3457.8 4096.3 4128.7 4129.4 3534.7 4034.7 4094.3 4100.4 4149.6 3471.7 3714.0 3954.8 4076.3 4102.2 3514.3 3936.0 3977.4 3978.0 3982.2 2938.8 3397.4 3435.0 3445.2 3461.2 4515.2 4805.4 5119.4 5132.4 5203.3 3822.6 4161.9 4562.2 4574.7 4578.0 5485.8 5500.8 5518.3 5531.1 5535.0 3637.7 3757.9 3785.9 3807.2 3817.8 4861.6 5061.4 5538.8 5791.9 5914.3 3831.2 3832.7 3844.7 3847.9 3855.9 3406.4 3460.1 3476.7 3783.7 3905.8 4186.3 4538.5 4547.6 4557.6 4565.9 4599.3 4927.4 5308.8 5381.5 5618.8 1258.6 1259.0 1259.6 1266.8 1279.3 799.9 825.1 827.8 890.3 968.0 4462.4 4904.7 4928.4 4931.9 4955.6 4498.6 4523.1 4767.0 4918.9 5453.9 4287.1 4357.6 4682.3 4687.7 4889.4 2769.6 2795.7 2829.7 2856.5 2878.2 4769.8 4986.7 5161.9 5500.7 5523.4 4635.3 4715.6 5125.2 5137.7 5212.0 5038.9 5263.4 5521.5 5521.9 5565.4 4434.2 4632.8 5127.9 5332.6 5365.8 4794.9 4835.2 4947.9 5020.9 5142.8 4565.4 4793.2 4873.5 5291.5 5520.4 3322.8 3366.4 3531.4 3870.4 3927.3 4949.5 5015.6 5258.5 5329.5 5387.8 4412.6 5055.6 5195.3 5209.5 5220.0 4636.1 5116.4 5137.7 5143.6 5165.1 4552.8 4633.5 5394.0 5418.6 5459.5 4547.6 5262.4 5397.1 5452.3 5631.5 4345.8 4603.0 5380.4 5423.7 5429.5 14:08:54 INFO - PROCESS | 1690 | 14:08:54 INFO - PROCESS | 1690 | [#5] yui.html Cycles:180 Average:19780.41 Median:4292.74 stddev:27681.65 (644.8%) stddev-sans-first:27722.25 14:08:54 INFO - PROCESS | 1690 | Values: 705.5 731.6 762.0 796.9 816.5 14834.6 15858.2 15863.5 15903.7 15919.8 14320.2 14453.9 14477.1 14477.1 14487.7 669.4 687.8 689.7 848.6 865.5 832.5 851.3 853.4 866.0 867.5 900.5 904.1 905.6 905.9 906.5 712.1 767.5 896.2 899.6 900.4 539.3 642.7 661.2 661.4 664.4 15038.4 15071.2 15078.1 15091.7 15108.4 13452.6 13464.6 13507.0 13512.7 13540.0 12465.3 12507.9 12530.5 12553.3 12640.7 4202.1 4324.6 4395.0 4443.3 4501.5 86237.0 101124.5 104497.5 104634.0 107154.5 10305.6 10733.0 10793.8 11050.3 11151.4 21710.7 21814.2 21918.3 22133.0 22136.0 7494.9 7519.2 7525.2 7586.9 7776.6 4138.6 4235.6 4274.3 4311.1 4394.9 3436.9 3450.4 3553.4 3555.7 3566.6 535.2 620.4 620.8 629.9 632.5 586.3 653.1 658.9 662.0 671.5 8839.5 9081.1 9176.2 9615.4 9682.5 623.4 626.7 660.3 664.4 682.4 4806.4 4843.5 4847.4 4867.3 4895.1 87246.0 103648.0 104569.5 105625.0 107325.5 74719.6 74929.0 75748.0 76335.0 82184.0 71443.6 72512.5 72792.9 74023.3 75173.1 9736.0 10460.0 10598.5 10677.1 10865.3 48177.0 49129.8 49637.8 49864.0 50178.0 62391.0 62546.0 63658.0 64252.7 65514.7 13072.7 13084.3 13092.7 13284.9 13305.0 14527.5 14539.7 14738.6 15151.8 15423.4 13738.0 13895.9 13901.7 14018.4 14355.8 13636.9 13767.7 13797.5 13805.7 13854.3 13364.3 13369.8 13616.4 13643.1 14164.3 10768.3 11080.3 11375.3 11518.3 11649.8 10845.4 10927.2 10930.2 11007.0 11129.1 14:08:54 INFO - PROCESS | 1690 | -------- Summary: end -------- 14:08:54 INFO - PROCESS | 1690 | 14:08:55 INFO - TEST-INFO | 1690: exit 0 14:08:55 INFO - TEST-OK | dromaeo_css | took 1119292ms 14:08:55 INFO - TEST-START | kraken 14:08:55 INFO - operating with platform_type : mac_ 14:08:55 INFO - Initialising browser for kraken test... 14:08:55 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmp06iMFz/profile http://localhost:49243/getInfo.html) 14:08:57 INFO - PROCESS | 1695 | __metrics Screen width/height:1600/1200 14:08:57 INFO - PROCESS | 1695 | colorDepth:24 14:08:57 INFO - PROCESS | 1695 | Browser inner width/height: 1024/689 14:08:57 INFO - PROCESS | 1695 | __metrics 14:08:57 INFO - PROCESS | 1695 | 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" 14:08:57 INFO - PROCESS | 1695 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:08:58 INFO - TEST-INFO | 1695: exit 0 14:08:58 INFO - Browser initialized. 14:08:58 INFO - Running cycle 1/1 for kraken test... 14:08:58 INFO - TEST-INFO | started process 1696 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmp06iMFz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:10 INFO - PROCESS | 1696 | RSS: Main: 227082240 14:09:10 INFO - PROCESS | 1696 | 14:09:13 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 14:09:14 INFO - PROCESS | 1696 | RSS: Main: 288649216 14:09:14 INFO - PROCESS | 1696 | 14:09:17 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 14:09:17 INFO - PROCESS | 1696 | RSS: Main: 290660352 14:09:17 INFO - PROCESS | 1696 | 14:09:21 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 14:09:21 INFO - PROCESS | 1696 | RSS: Main: 380710912 14:09:21 INFO - PROCESS | 1696 | 14:09:23 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 14:09:24 INFO - PROCESS | 1696 | RSS: Main: 282107904 14:09:24 INFO - PROCESS | 1696 | 14:09:26 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:09:27 INFO - PROCESS | 1696 | RSS: Main: 285392896 14:09:27 INFO - PROCESS | 1696 | 14:09:29 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 14:09:30 INFO - PROCESS | 1696 | RSS: Main: 328716288 14:09:30 INFO - PROCESS | 1696 | 14:09:33 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 14:09:34 INFO - PROCESS | 1696 | RSS: Main: 330194944 14:09:34 INFO - PROCESS | 1696 | 14:09:36 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 14:09:37 INFO - PROCESS | 1696 | RSS: Main: 327012352 14:09:37 INFO - PROCESS | 1696 | 14:09:39 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:09:39 INFO - PROCESS | 1696 | RSS: Main: 303493120 14:09:39 INFO - PROCESS | 1696 | 14:09:41 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:09:42 INFO - PROCESS | 1696 | RSS: Main: 306995200 14:09:42 INFO - PROCESS | 1696 | 14:09:44 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:09:45 INFO - PROCESS | 1696 | RSS: Main: 312823808 14:09:45 INFO - PROCESS | 1696 | 14:09:48 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:09:48 INFO - PROCESS | 1696 | RSS: Main: 327331840 14:09:48 INFO - PROCESS | 1696 | 14:09:51 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:09:52 INFO - PROCESS | 1696 | RSS: Main: 321581056 14:09:52 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 14:09:54 INFO - PROCESS | 1696 | RSS: Main: 365301760 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | __start_tp_report 14:09:54 INFO - PROCESS | 1696 | _x_x_mozilla_page_load 14:09:54 INFO - PROCESS | 1696 | _x_x_mozilla_page_load_details 14:09:54 INFO - PROCESS | 1696 | |i|pagename|runs| 14:09:54 INFO - PROCESS | 1696 | |0;ai-astar;113;116;113;114;116;166;138;114;113;113 14:09:54 INFO - PROCESS | 1696 | |1;audio-beat-detection;147;114;118;177;140;127;109;108;125;130 14:09:54 INFO - PROCESS | 1696 | |2;audio-dft;183;183;186;187;184;184;184;184;184;182 14:09:54 INFO - PROCESS | 1696 | |3;audio-fft;80;59;59;88;63;60;58;58;74;60 14:09:54 INFO - PROCESS | 1696 | |4;audio-oscillator;89;71;86;69;68;69;83;67;69;83 14:09:54 INFO - PROCESS | 1696 | |5;imaging-gaussian-blur;92;88;92;88;92;88;92;89;91;87 14:09:54 INFO - PROCESS | 1696 | |6;imaging-darkroom;98;98;102;98;100;98;101;99;100;100 14:09:54 INFO - PROCESS | 1696 | |7;imaging-desaturate;87;85;85;84;84;87;86;85;84;84 14:09:54 INFO - PROCESS | 1696 | |8;json-parse-financial;55;57;55;55;56;56;56;56;55;56 14:09:54 INFO - PROCESS | 1696 | |9;json-stringify-tinderbox;79;76;69;77;76;70;72;72;72;72 14:09:54 INFO - PROCESS | 1696 | |10;stanford-crypto-aes;88;87;89;87;89;91;105;106;110;78 14:09:54 INFO - PROCESS | 1696 | |11;stanford-crypto-ccm;145;132;141;141;141;162;150;139;194;176 14:09:54 INFO - PROCESS | 1696 | |12;stanford-crypto-pbkdf2;173;175;179;176;175;184;175;175;226;230 14:09:54 INFO - PROCESS | 1696 | |13;stanford-crypto-sha256-iterative;68;67;71;85;84;84;79;67;66;68 14:09:54 INFO - PROCESS | 1696 | __end_tp_report 14:09:54 INFO - PROCESS | 1696 | __start_cc_report 14:09:54 INFO - PROCESS | 1696 | _x_x_mozilla_cycle_collect,1972 14:09:54 INFO - PROCESS | 1696 | __end_cc_report 14:09:54 INFO - PROCESS | 1696 | __startTimestamp1484518194689__endTimestamp 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | ------- Summary: start ------- 14:09:54 INFO - PROCESS | 1696 | Number of tests: 14 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#0] ai-astar Cycles:10 Average:121.60 Median:115.00 stddev:17.37 (15.1%) stddev-sans-first:18.14 14:09:54 INFO - PROCESS | 1696 | Values: 113.0 116.0 113.0 114.0 116.0 166.0 138.0 114.0 113.0 113.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:128.50 stddev:20.96 (16.3%) stddev-sans-first:21.26 14:09:54 INFO - PROCESS | 1696 | Values: 147.0 114.0 118.0 177.0 140.0 127.0 109.0 108.0 125.0 130.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.00 stddev:1.45 (0.8%) stddev-sans-first:1.48 14:09:54 INFO - PROCESS | 1696 | Values: 183.0 183.0 186.0 187.0 184.0 184.0 184.0 184.0 184.0 182.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#3] audio-fft Cycles:10 Average:65.90 Median:61.50 stddev:10.81 (17.6%) stddev-sans-first:10.19 14:09:54 INFO - PROCESS | 1696 | Values: 80.0 59.0 59.0 88.0 63.0 60.0 58.0 58.0 74.0 60.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:77.00 stddev:8.69 (11.3%) stddev-sans-first:7.70 14:09:54 INFO - PROCESS | 1696 | Values: 89.0 71.0 86.0 69.0 68.0 69.0 83.0 67.0 69.0 83.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:91.50 stddev:2.08 (2.3%) stddev-sans-first:2.06 14:09:54 INFO - PROCESS | 1696 | Values: 92.0 88.0 92.0 88.0 92.0 88.0 92.0 89.0 91.0 87.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#6] imaging-darkroom Cycles:10 Average:99.40 Median:98.00 stddev:1.43 (1.5%) stddev-sans-first:1.42 14:09:54 INFO - PROCESS | 1696 | Values: 98.0 98.0 102.0 98.0 100.0 98.0 101.0 99.0 100.0 100.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:1.20 (1.4%) stddev-sans-first:1.05 14:09:54 INFO - PROCESS | 1696 | Values: 87.0 85.0 85.0 84.0 84.0 87.0 86.0 85.0 84.0 84.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 14:09:54 INFO - PROCESS | 1696 | Values: 55.0 57.0 55.0 55.0 56.0 56.0 56.0 56.0 55.0 56.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#9] json-stringify-tinderbox Cycles:10 Average:73.50 Median:74.00 stddev:3.27 (4.4%) stddev-sans-first:2.80 14:09:54 INFO - PROCESS | 1696 | Values: 79.0 76.0 69.0 77.0 76.0 70.0 72.0 72.0 72.0 72.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#10] stanford-crypto-aes Cycles:10 Average:93.00 Median:87.50 stddev:10.33 (11.8%) stddev-sans-first:10.79 14:09:54 INFO - PROCESS | 1696 | Values: 88.0 87.0 89.0 87.0 89.0 91.0 105.0 106.0 110.0 78.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#11] stanford-crypto-ccm Cycles:10 Average:152.10 Median:147.50 stddev:19.51 (13.2%) stddev-sans-first:20.52 14:09:54 INFO - PROCESS | 1696 | Values: 145.0 132.0 141.0 141.0 141.0 162.0 150.0 139.0 194.0 176.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.80 Median:177.50 stddev:21.95 (12.4%) stddev-sans-first:22.70 14:09:54 INFO - PROCESS | 1696 | Values: 173.0 175.0 179.0 176.0 175.0 184.0 175.0 175.0 226.0 230.0 14:09:54 INFO - PROCESS | 1696 | 14:09:54 INFO - PROCESS | 1696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:75.00 stddev:8.09 (10.8%) stddev-sans-first:8.29 14:09:54 INFO - PROCESS | 1696 | Values: 68.0 67.0 71.0 85.0 84.0 84.0 79.0 67.0 66.0 68.0 14:09:54 INFO - PROCESS | 1696 | -------- Summary: end -------- 14:09:54 INFO - PROCESS | 1696 | 14:09:55 INFO - TEST-INFO | 1696: exit 0 14:09:55 INFO - TEST-OK | kraken | took 60150ms 14:09:55 INFO - SUITE-END | took 1179s 14:09:55 INFO - Completed test suite (00:19:39) 14:09:55 INFO - javascript benchmark 14:09:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.3517514084747, 3332.5501057357255, 3355.328934213158, 3355.496675498675, 3406.199543107369, 4905.681130726509, 5159.871003224921, 5659.830205093848, 5729.140628905661, 5732.885342293157, 5698.0883058710615, 5709.400512946143, 5807.41925807419, 5809.593328467009, 5849.034909239981, 4290.97854510727, 5125.179971204608, 5139.614528910328, 5173.172292433212, 5205.063088644042, 5197.610179236553, 5250.396204436482, 5285.814996475124, 5302.2841916341185, 5331.493508116722, 5096.541311282002, 5253.579713622901, 5262.473752624745, 5290.0, 5297.788088476456, 5130.769115389817, 5182.404023537304, 5183.688978661293, 5185.688858668492, 5188.507091826271, 5065.366829146356, 5144.3312369392115, 5156.819511317123, 5158.226266060084, 5168.715720635363, 4576.427946506687, 5635.63368381058, 5641.238432811559, 5642.830715078554, 5645.745941432645, 6178.0, 6182.412670796267, 6191.566590338678, 6239.906401403982, 6265.5614107012525, 6236.812895613139, 6283.717232724538, 6290.21372328459, 6296.559240853142, 6311.0, 5770.307563092456, 5842.883142337215, 5852.795152169696, 5871.236739223959, 5897.705114744245, 5437.401885792559, 5521.1442226454965, 6112.419320164578, 6287.685615719196, 6292.465140463112, 6012.879742405127, 6219.284782250099, 6226.283977342573, 6230.439260466489, 6235.064740288993, 6232.096346029891, 6292.182016337938, 6301.747930082837, 6303.054541818764, 6312.179416675803, 5964.552658550626, 5966.940330596725, 6131.816045518642, 6149.661768602769, 6165.506759459233, 6049.0926361046195, 6059.575829691968, 6064.06007068905, 6070.969645151746, 6104.20645316106, 4819.2530157825595, 4825.662203645781, 4830.106430310334, 4839.370881785346, 4875.731834749052, 4327.697061205686, 4338.717983331137, 4385.101054283864, 4453.087117140978, 4454.799534020977, 5868.09044598088, 5875.41245875409, 5907.586468947133, 5932.584719069624, 5974.701264936736, 5399.352077750616, 6033.939660603338, 6178.196834411588, 6201.782937597162, 6250.374962503804, 5644.520215781622, 5893.14549390336, 5922.615030023121, 5924.851878703067, 5936.5250779937505, 5383.353997520323, 5402.216678581583, 5429.782808687687, 5471.987682278791, 5486.615936884459, 6383.840403989844, 6413.935860641427, 6414.390632889868, 6417.1657684500715, 6419.2296924369375, 6219.813405597839, 6226.3151053385, 6232.127502149612, 6236.656983865931, 6236.844078898064, 6127.556056270746, 6169.598976066542, 6187.969060154671, 6216.129741836237, 6332.145160403286, 6122.764110201883, 6144.969275153596, 6145.002874065857, 6175.320714721287, 6177.722002509808, 6136.785212517719, 6154.353792851686, 6155.661438620739, 6167.290761562478, 6192.349803270592, 6049.697515124314, 6061.787837425669, 6096.481799046954, 6103.115048318058, 6150.538709596709, 5050.898982020412, 6091.113275426838, 6124.74712746768, 6149.831532008904, 6162.168107305456, 5765.682887441063, 6107.977837958671, 6123.30323506545, 6124.808163753285, 6133.1510485532735, 4430.291153415567, 4506.7070640408265, 5710.143478478095, 5892.970535147469, 6150.077488376779, 6061.848453788691, 6070.939290607214, 6082.118092876596, 6082.300535438481, 6110.7250173741395], "value": 5648.488105293696, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.7670223132855, 471.75704512176236, 495.4525249599193, 519.874471768621, 523.0010679601961, 35317.82341088294, 41538.7923060385, 41553.961150971205, 41582.16835663285, 41631.583684163226, 42540.0, 42892.142157156835, 42923.49767758129, 43028.0, 43049.923751906215, 8385.958070209641, 9282.582283797228, 9435.811283774321, 9496.0, 9498.0, 8333.416660833744, 11127.221094523387, 11376.431178441086, 11387.829182562267, 11541.769164616702, 9576.712698619052, 11265.098792096613, 11318.603848865292, 11321.490532925996, 11330.830037549444, 8387.580620968989, 8608.01007884095, 11247.381394023325, 11294.20940534163, 11313.09495240383, 10868.239223254375, 11168.66494005181, 11206.383648899307, 11286.26639268453, 11323.603673871376, 39184.41223381623, 39541.20917581632, 39652.0, 39694.80915572537, 39722.80138599288, 4029.979850100731, 4063.6952228582677, 4081.265372232997, 4121.381792731085, 4221.261279276115, 30171.44456159446, 30182.84908575465, 30209.395812083854, 30862.845685771426, 31106.377872442423, 3106.2079169811777, 3110.5334199869976, 3133.310671652233, 3138.184072141237, 3217.211783113129, 448937.0, 456617.0, 457972.0, 458250.0, 460899.0, 51494.485055149715, 61757.0, 63564.0, 63658.363416365246, 63785.72428551403, 66139.0, 67008.0, 67051.32948670548, 67116.328836711, 67259.66370168216, 15952.361905523881, 16516.339346426008, 16533.669326613643, 16553.0, 16658.6668266634, 11435.028022618171, 11715.238509497025, 12395.75208495825, 12438.81341779874, 12641.11512194156, 18105.732598718227, 18345.54136146607, 18435.907820460812, 18574.349897753513, 18590.977496237567, 5799.855003624859, 6558.508111891627, 6613.338666133348, 6633.374823168355, 6792.0, 762.9771106866802, 867.9566021698889, 879.9396726944017, 894.2532984957503, 914.1407077347405, 29758.0, 29869.0, 29951.850240748656, 30363.0, 30570.847145764128, 1069.385103565453, 1080.8432777247256, 1105.745678493951, 1117.5976648406568, 1159.6347150647518, 13401.664958375924, 15516.612084697746, 15587.298571564306, 15599.53201403937, 15893.523194304189, 548538.0, 839878.0, 861569.0, 861590.0, 862389.0, 51076.23385649218, 51631.0, 51653.48346516487, 51749.2237616436, 51841.2223816643, 1406.2054938959454, 1411.6682579593787, 1449.5578848451323, 1451.5935538049364, 1451.9491817786327, 27940.441191175654, 27959.161225163276, 28023.859880700467, 28744.281392965342, 28817.7118228815, 45262.86842828824, 45522.0, 45658.0, 45761.313580296985, 45832.312515312966, 442384.0, 443792.0, 446807.0, 447798.0, 449516.0, 22379.77620223842, 22995.88502057479, 24347.634785477876, 24656.753432466165, 24681.259562213163, 40807.59192408038, 43202.567974321115, 43228.0, 43986.56013439953, 44769.88075298144, 32181.03456896297, 35159.82420087883, 35222.64777352194, 36259.818700906326, 36392.0, 34659.82670086633, 35208.0, 36060.0, 36174.09564760902, 36535.45196822103, 34334.82832585921, 34489.31021379609, 34740.826295868355, 35032.0, 35323.0, 29853.402931941673, 30990.38019239648, 31382.372352553277, 31425.0, 31480.84259578779, 23194.1882034128, 23295.41761455977, 23559.882200588887, 23880.40298992539, 24044.639330409707], "value": 19631.312390225085, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.49076385421876, 356.8572570971611, 366.7799320407754, 368.7179307829511, 382.9253295607356, 15393.615159621015, 15581.766273505893, 16353.754693679604, 20534.281300154496, 21333.35999920005, 21373.786262137375, 21415.0, 22140.88929555354, 22148.557028859414, 22258.0, 5761.078227483604, 5829.743957884666, 5888.970555147218, 6019.367966363535, 6022.247219097613, 5819.709014549277, 5875.970620146893, 5914.585978981473, 5928.851778705523, 5937.67342796146, 4205.810738516774, 4414.492333381654, 6331.398517140888, 6619.4704423646235, 6654.268030516663, 5651.0, 6336.809895703136, 6497.9350206498275, 6637.0, 6645.966770166118, 5773.162891380768, 5773.913391299134, 5779.0, 5786.739596718157, 5793.449622285876, 26237.606435903475, 27202.0, 27265.318367040785, 27373.863130684418, 27608.447831043468, 2669.919902402931, 2743.7804975601903, 2744.9588256176175, 2747.5191841427672, 2761.4811853480705, 15430.691386172326, 15900.76148857768, 16154.273057712431, 16321.59196020097, 16573.17695053543, 1841.7974022857475, 1847.104154485087, 1847.29802674984, 1858.9721154182698, 1910.436421255733, 93270.44588395662, 98322.016779832, 123385.38307308496, 124539.5092098162, 135741.3212933929, 11141.164412669083, 11232.943835280772, 11316.660500185008, 11390.430478476042, 11577.594784182682, 14270.429182832571, 14315.856841431661, 14819.925900370428, 14859.777103343458, 14893.925530372278, 8563.0, 8849.51327676984, 8863.911360886437, 8976.147266009719, 8988.955055224682, 7117.857642847218, 8799.29605631548, 8839.646414143492, 8990.0, 9036.593353299117, 7181.748638797617, 7334.816629584197, 7348.5958272294465, 7357.448191385561, 7384.372328352043, 1722.3455087067084, 1905.5998240369677, 1941.1847024249848, 1943.154727693458, 1954.1206457094365, 1030.5620111452752, 1048.5438834107188, 1062.2086545523634, 1088.88022317545, 1108.152263518409, 19021.239150434103, 20792.0, 21052.894735526224, 22763.544729105324, 22996.310110696704, 991.9256055795844, 1028.9453310356944, 1065.3341661461586, 1098.3849044535086, 1101.2566517600587, 10918.50866710984, 11501.482433290523, 11757.823632645517, 11900.285982841056, 11949.76100478003, 557804.0, 634915.82542087, 703725.0, 706119.0, 746850.0, 103984.0, 117139.0, 123621.29136125931, 131750.0, 135861.0, 985.6451677396132, 1002.7966440271703, 1059.5126241928645, 1062.8033813744482, 1073.291627525845, 16036.599085022968, 20597.176112955312, 20600.690989634866, 20728.48178795542, 20742.0, 57740.0, 58087.70956145192, 58689.0, 60521.39478605158, 60651.69674151601, 70144.29855701582, 81738.0, 83922.32155356981, 85342.57328713317, 87851.0, 7151.141862976476, 7347.666679950576, 7457.2542745724995, 7571.3564347031115, 7710.421718371257, 12752.553660621834, 13222.140560863512, 13248.873845723221, 13706.314684265548, 13776.448942042207, 9797.65708200238, 9941.353812002197, 10952.069074128469, 11520.308781473139, 11747.412629368668, 11117.666470005914, 11439.542418303176, 11444.713882153013, 11523.711907202387, 11735.354555499189, 11090.65049779188, 11372.943135284271, 11588.6523404298, 11919.106067045179, 12043.036557075238, 6406.711697973509, 8332.291755200877, 8408.2432581068, 8476.23713865755, 8544.57277136153, 10427.843582346422, 10788.784224315314, 11350.54597816078, 11871.821922670993, 11941.343226122646], "value": 10081.1804855282, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.054593422407, 1442.6032840968733, 1450.1226757811523, 1469.0818238600868, 1471.0, 8140.267375936164, 8528.317734581235, 8544.017437994633, 8553.315734741222, 8581.785455363603, 7408.629568521579, 7737.767866963986, 7739.6904123834975, 7833.725819596315, 7839.882401763978, 2091.3098677436487, 2257.503349263168, 2335.8948847301826, 2341.9297421077395, 2350.905963761456, 2329.091654254842, 2330.067972810872, 2344.0272287000876, 2365.82256330775, 2379.5359904818565, 2266.46738016566, 2300.6894069300597, 2306.642470417088, 2312.364099872532, 2312.722473303206, 2012.7886571909885, 2289.919852805152, 2297.666838308436, 2314.5139520700673, 2318.07277089164, 2278.624027035537, 2317.5480781247666, 2340.180936672168, 2350.670906073151, 2353.97646023541, 8341.332693384515, 8449.155084491564, 8454.28138608219, 8456.57717114148, 8461.407701460901, 5061.367329083864, 5219.42586315505, 5224.686518808883, 5233.502817232356, 5237.895242095175, 3327.4010678077934, 3529.364714351416, 3533.9116522086897, 3549.733769967237, 3611.674949254553, 1133.8185890257603, 1137.1528211482498, 1162.9360385178811, 1200.8619008813923, 1262.8926541243914, 10698.51856666452, 10713.839292410543, 10717.410542420164, 10734.892651073467, 10740.14078873696, 4578.519255478193, 4599.402077729874, 4610.76946152691, 4642.303654451859, 4703.764811759398, 9423.811523769624, 9494.05059494045, 9506.667266645634, 9515.476648784244, 9524.714258572254, 5240.0567897778765, 5248.1602943529615, 5256.290400795843, 5260.894782104337, 5262.368515778131, 4643.8374656886845, 4745.454272758608, 4771.642126840501, 4844.588210002189, 4876.390451193601, 3363.5963684358035, 3440.7419443541335, 3458.654134586521, 3607.7113830893463, 3738.9065273367837, 994.8060128274917, 1147.833564133196, 1161.6573110932295, 1163.040491594438, 1166.8249762535688, 768.9423293253028, 769.4190885881236, 780.0717146595533, 790.2097902097902, 792.9603519823986, 5451.536619387317, 5544.77820887168, 5559.444055594408, 5640.661560306313, 5648.915266271009, 943.2878176976476, 944.5607792376578, 954.5322791831952, 997.4015590645699, 1030.3199888073834, 3590.551181102362, 3714.795686237229, 3737.7383583149463, 3818.217265460574, 3824.8661296854475, 9683.757906052406, 9746.415215086976, 9771.071748183911, 9897.703068907944, 9989.500524973722, 7512.39900807934, 9633.373830700983, 9854.458004809805, 9882.357646752938, 10009.249306302056, 7764.262395072459, 7911.28798408146, 7946.841063178704, 7956.164602716747, 7965.721199757981, 5263.34208223972, 5447.0467668157125, 5453.8457309363375, 5796.782675638163, 5898.262717160355, 9138.08619138081, 9301.581428835854, 9303.953480232556, 9313.906860931575, 9314.161725444743, 8932.46405215689, 9138.68014619485, 9362.0, 9362.438253704799, 9405.24758019343, 7110.928890711233, 7162.534435261691, 7179.748708795167, 7219.963900180465, 7272.018277532466, 7125.572465652078, 7390.482666213314, 7401.925980740339, 7582.090149182133, 7804.0, 6889.138857642794, 7003.229644739176, 7103.112110986127, 7123.857522849617, 7210.783676489714, 6997.650117494003, 7015.473839462163, 7076.25699301566, 7185.820354491179, 7201.279872012757, 5244.685318880879, 5329.946700532945, 6163.106349579376, 6385.648789316632, 6400.679966001774, 4418.823247070081, 4853.6602437829015, 4939.975300123477, 4941.382327209099, 5061.114304996538, 4275.850345238026, 4433.623142032963, 4898.485659005753, 5013.671377085003, 5069.69581825077], "value": 4358.826250238428, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.43915016398677, 355.6887723242163, 360.45391232283094, 372.6552938531861, 373.41374042752886, 4839.8790030249265, 5300.337457817773, 5346.930613877231, 5371.382291036532, 5398.433164517728, 4336.392904993303, 4908.828191013306, 5098.413682426522, 5104.821331253407, 5237.764300606473, 3413.692767650911, 3457.82710864457, 4096.262672718909, 4128.669706423494, 4129.359949207877, 3534.6995505381947, 4034.69739769517, 4094.263032654121, 4100.416737455399, 4149.585041495857, 3471.722262219029, 3714.034351068728, 3954.8220330085214, 4076.3070278052655, 4102.220578090169, 3514.3291098764867, 3935.9963209381426, 3977.448794969964, 3977.980110099431, 3982.183652351261, 2938.7942844000927, 3397.3545026444895, 3435.003848883821, 3445.242046749711, 3461.2212252243294, 4515.2324104902245, 4805.351277577517, 5119.385673719177, 5132.435432102503, 5203.349581302337, 3822.617738226183, 4161.9375709364385, 4562.22442184826, 4574.72551646899, 4577.9942550268515, 5485.835424937259, 5500.7524661390335, 5518.255035570187, 5531.0873705838485, 5535.03136951036, 3637.7453578249533, 3757.868474603376, 3785.867494637702, 3807.162424266657, 3817.751846129993, 4861.562459378708, 5061.367329083864, 5538.833834984957, 5791.913121303184, 5914.319853216892, 3831.1762970961377, 3832.7317087803585, 3844.6732027777393, 3847.8845634630447, 3855.9036024099623, 3406.3527929693278, 3460.117669994135, 3476.66971637694, 3783.710854932781, 3905.7656540607654, 4186.28833098374, 4538.478075021349, 4547.636189104864, 4557.612602928722, 4565.908681826345, 4599.33309670096, 4927.408710954636, 5308.840734777963, 5381.461853814587, 5618.775248989995, 1258.5783762439685, 1258.9811152832715, 1259.5843371687322, 1266.835311409511, 1279.2708156350977, 799.8641928461599, 825.0676735289085, 827.8120896513523, 890.3455959869491, 967.9612815487443, 4462.359146487616, 4904.7438178438315, 4928.433230178575, 4931.926021109686, 4955.603551715854, 4498.617617502549, 4523.095380923828, 4767.0, 4918.926216106761, 5453.927507547186, 4287.098740146452, 4357.564243575617, 4682.344471773954, 4687.742174180385, 4889.435380678149, 2769.612254284402, 2795.720427957188, 2829.7311755383616, 2856.486292063013, 2878.1797187801376, 4769.833055843029, 4986.7114281717695, 5161.922571161435, 5500.697461639568, 5523.447655234444, 4635.327877457749, 4715.622750179978, 5125.207930584915, 5137.717425541631, 5211.973940130275, 5038.924416133761, 5263.394709608444, 5521.542913403578, 5521.889562208814, 5565.41563135873, 4434.246178149658, 4632.768361581975, 5127.948720512747, 5332.626716129834, 5365.839024829262, 4794.928076078932, 4835.178019736723, 4947.925781113358, 5020.899582008413, 5142.808610982038, 4565.406497155349, 4793.209120495079, 4873.537013983666, 5291.5340452004, 5520.420355862577, 3322.7539672622765, 3366.444536651425, 3531.404417752898, 3870.4000879863665, 3927.2930872443235, 4949.5151454562765, 5015.648904576645, 5258.474152584711, 5329.520343169133, 5387.7844886205685, 4412.624926881251, 5055.646104772778, 5195.272661827272, 5209.47905209476, 5220.0, 4636.142313671981, 5116.411612664591, 5137.717425541631, 5143.562797162133, 5165.063101336998, 4552.770751897036, 4633.536646335474, 5394.0, 5418.647787893774, 5459.508644222039, 4547.636189104797, 5262.394824595068, 5397.085573790109, 5452.318460192476, 5631.549476041989, 4345.847895323648, 4602.953970460252, 5380.439672494933, 5423.728813559227, 5429.511343979061], "value": 3906.597892085894, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.537872693386, 731.6085894046686, 762.0093877958656, 796.860489500015, 816.5223344343559, 14834.629134271649, 15858.207089645515, 15863.524094277162, 15903.68192636148, 15919.840801591981, 14320.212388318638, 14453.92773036136, 14477.058991165566, 14477.058991165593, 14487.710245795079, 669.3875104279579, 687.779910428663, 689.672405607335, 848.5587494502855, 865.5412631305387, 832.4589017138878, 851.2636569367514, 853.3812985585463, 866.0213958227195, 867.453504292295, 900.545224661545, 904.0688091266006, 905.6060613633091, 905.868649045888, 906.4742449379344, 712.0671919785098, 767.48578452437, 896.1576118448637, 899.5861903524386, 900.3967341880956, 539.2773683264405, 642.7493277621685, 661.2263651527724, 661.3882159002903, 664.4385494257344, 15038.398464061424, 15071.171085590287, 15078.095314281069, 15091.698166036727, 15108.39566417342, 13452.596422107352, 13464.596062118153, 13506.98697597684, 13512.729745405135, 13540.0, 12465.252084874937, 12507.874921250763, 12530.498780048787, 12553.309567973758, 12640.74718505634, 4202.052766956718, 4324.589164029412, 4394.978025109886, 4443.333499974998, 4501.504834468205, 86237.0, 101124.49437752838, 104497.47751261195, 104634.0, 107154.46422767836, 10305.639302624371, 10733.0, 10793.784124317626, 11050.281731687415, 11151.38667373286, 21710.674339884914, 21814.236501722364, 21918.342449726533, 22133.0, 22136.003879825446, 7494.85010299791, 7519.210482899326, 7525.2098529654695, 7586.924130758732, 7776.611169441505, 4138.6482149017065, 4235.618794308527, 4274.337477690963, 4311.137772445523, 4394.868153955386, 3436.862525499002, 3450.413429716954, 3553.3959226931483, 3555.7333200009584, 3566.625504322009, 535.2399592578548, 620.3920158244945, 620.8137558732362, 629.8771739510752, 632.4655665962255, 586.2642383808293, 653.098723761216, 658.9472842172614, 661.9702113404908, 671.4863129705778, 8839.469631821983, 9081.091890810865, 9176.183722724047, 9615.375000625078, 9682.467464289532, 623.4077626255075, 626.6584711332334, 660.2638058564762, 664.4119953840789, 682.3619915379137, 4806.351142595775, 4843.539863712942, 4847.394075740533, 4867.294242334841, 4895.094407534618, 87246.0, 103648.0, 104569.47715261375, 105625.0, 107325.46337268264, 74719.62640186764, 74929.0, 75748.0, 76335.0, 82184.0, 71443.64278178576, 72512.54974900578, 72792.9081063795, 74023.25976740272, 75173.09990051521, 9735.951320243354, 10460.0, 10598.47007649599, 10677.14582833356, 10865.293755905841, 48177.0, 49129.771755706395, 49637.75181124071, 49864.0, 50178.0, 62391.0, 62546.0, 63658.0, 64252.71494570176, 65514.689706204656, 13072.738545228853, 13084.28036458004, 13092.738145237232, 13284.937205023381, 13305.002124840483, 14527.491537796126, 14539.709205816036, 14738.55784326472, 15151.848481515484, 15423.383064677737, 13738.0, 13895.861041389457, 13901.652458688613, 14018.369173387426, 14355.784663230268, 13636.93181534086, 13767.655808604864, 13797.51708690191, 13805.723885522033, 13854.307284635526, 13364.331783410596, 13369.799453008018, 13616.38726257301, 13643.113197642122, 14164.291785410482, 10768.300060496043, 11080.279781814157, 11375.26060806045, 11518.251313664585, 11649.825252621047, 10845.403502807421, 10927.235093543375, 10930.180236482136, 11007.0, 11129.109671226444], "value": 7427.566061492306, "unit": "score"}], "name": "dromaeo_css", "value": 7217.880346995843, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 113.0, 114.0, 116.0, 166.0, 138.0, 114.0, 113.0, 113.0], "value": 121.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 114.0, 118.0, 177.0, 140.0, 127.0, 109.0, 108.0, 125.0, 130.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 186.0, 187.0, 184.0, 184.0, 184.0, 184.0, 184.0, 182.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 88.0, 63.0, 60.0, 58.0, 58.0, 74.0, 60.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 86.0, 69.0, 68.0, 69.0, 83.0, 67.0, 69.0, 83.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 92.0, 88.0, 92.0, 88.0, 92.0, 89.0, 91.0, 87.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 102.0, 98.0, 100.0, 98.0, 101.0, 99.0, 100.0, 100.0], "value": 99.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 84.0, 84.0, 87.0, 86.0, 85.0, 84.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0, 55.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 69.0, 77.0, 76.0, 70.0, 72.0, 72.0, 72.0, 72.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 87.0, 89.0, 91.0, 105.0, 106.0, 110.0, 78.0], "value": 93.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 132.0, 141.0, 141.0, 141.0, 162.0, 150.0, 139.0, 194.0, 176.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 179.0, 176.0, 175.0, 184.0, 175.0, 175.0, 226.0, 230.0], "value": 186.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 71.0, 85.0, 84.0, 84.0, 79.0, 67.0, 66.0, 68.0], "value": 73.9, "unit": "score"}], "name": "kraken", "value": 1485.8999999999999, "alertThreshold": 2.0}]} 14:09:55 INFO - Return code: 0 14:09:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:09:55 ERROR - # TBPL SUCCESS # 14:09:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:09:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:09:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:09:56 INFO - 2017-01-15 14:09:56.015 screenresolution[1700:18277] starting screenresolution argv=screenresolution get 14:09:56 INFO - 2017-01-15 14:09:56.018 screenresolution[1700:18277] Display 0: 1600x1200x32@60 14:09:56 INFO - 2017-01-15 14:09:56.025 screenresolution[1701:18280] starting screenresolution argv=screenresolution list 14:09:56 INFO - Available Modes on Display 0 14:09:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:09:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:09:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:09:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:09:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:09:56 INFO - Intel Iris: 14:09:56 INFO - Chipset Model: Intel Iris 14:09:56 INFO - Type: GPU 14:09:56 INFO - Bus: Built-In 14:09:56 INFO - VRAM (Dynamic, Max): 1536 MB 14:09:56 INFO - Vendor: Intel (0x8086) 14:09:56 INFO - Device ID: 0x0a2e 14:09:56 INFO - Revision ID: 0x0009 14:09:56 INFO - Displays: 14:09:56 INFO - Display: 14:09:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:09:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:09:56 INFO - Display Serial Number: 1600x1200 60 14:09:56 INFO - Main Display: Yes 14:09:56 INFO - Mirror: Off 14:09:56 INFO - Online: Yes 14:09:56 INFO - Rotation: Supported 14:09:56 INFO - Return code: 0 14:09:56 INFO - Running post-action listener: _resource_record_post_action 14:09:56 INFO - [mozharness: 2017-01-15 22:09:56.264498Z] Finished run-tests step (success) 14:09:56 INFO - Running post-run listener: _resource_record_post_run 14:09:56 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 32128000; Write bytes: 555026944; Read time: 192; Write time: 1691 14:09:56 INFO - TinderboxPrint: CPU usage
53.7% 14:09:56 INFO - TinderboxPrint: I/O read bytes / time
32,128,000 / 192 14:09:56 INFO - TinderboxPrint: I/O write bytes / time
555,026,944 / 1,691 14:09:56 INFO - TinderboxPrint: CPU idle
2,226.8 (46.3%) 14:09:56 INFO - TinderboxPrint: CPU system
963.1 (20.0%) 14:09:56 INFO - TinderboxPrint: CPU user
1,623.8 (33.7%) 14:09:56 INFO - TinderboxPrint: Swap in / out
279,068,672 / 0 14:09:56 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 232841728; Write bytes: 226813440; Read time: 17577; Write time: 501 14:09:56 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31190016; Write bytes: 301097984; Read time: 178; Write time: 1128 14:09:56 INFO - Running post-run listener: _upload_blobber_files 14:09:56 INFO - Blob upload gear active. 14:09:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:09:56 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 14:09:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:09:57 INFO - (blobuploader) - INFO - Open directory for files ... 14:09:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:09:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:09:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:57 INFO - (blobuploader) - INFO - Done attempting. 14:09:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:09:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:09:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:58 INFO - (blobuploader) - INFO - Done attempting. 14:09:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:09:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:09:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:59 INFO - (blobuploader) - INFO - Done attempting. 14:09:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:09:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:10:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:02 INFO - (blobuploader) - INFO - Done attempting. 14:10:02 INFO - (blobuploader) - INFO - Iteration through files over. 14:10:02 INFO - Return code: 0 14:10:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:10:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:10:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fed077e0cc7b37b6073474d5c2b0b165c581a7434abb606b4837c1b0f997e6cd92c1fa68e390ead71916793d6cde3fba13de6d2c149e0e1e2452c18616b00994", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa24543e2e62863e39b3d9fe47e6dd1e2b189389d6e8dce847ebf9a1ccf919392298763808b447fb8e6fd0b824002c7988aacfd46391d3da8714760d367df05f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5402a1d6e7fb8ba49bbde56432b814753514a3ce185f4c1afc386207abfc91a2c0ec481eb43b61816e92016e50231d769794ad74aefe7c55dbb1e9e6a68f8e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e348caeef8e6d21fe04afdc72770ac96da3c76c0c77985220aad0109ba1b0db46c233ffad25aede48efc66891e46fe129650b754a6ebdfd493eef4d9244b78a"} 14:10:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:10:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:10:02 INFO - Contents: 14:10:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fed077e0cc7b37b6073474d5c2b0b165c581a7434abb606b4837c1b0f997e6cd92c1fa68e390ead71916793d6cde3fba13de6d2c149e0e1e2452c18616b00994", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa24543e2e62863e39b3d9fe47e6dd1e2b189389d6e8dce847ebf9a1ccf919392298763808b447fb8e6fd0b824002c7988aacfd46391d3da8714760d367df05f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5402a1d6e7fb8ba49bbde56432b814753514a3ce185f4c1afc386207abfc91a2c0ec481eb43b61816e92016e50231d769794ad74aefe7c55dbb1e9e6a68f8e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e348caeef8e6d21fe04afdc72770ac96da3c76c0c77985220aad0109ba1b0db46c233ffad25aede48efc66891e46fe129650b754a6ebdfd493eef4d9244b78a"} 14:10:02 INFO - Running post-run listener: copy_logs_to_upload_dir 14:10:02 INFO - Copying logs to upload dir... 14:10:02 INFO - mkdir: /builds/slave/test/build/upload/logs 14:10:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.444803 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-15 14:10:02.242216) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 14:10:02.246570) ========= 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.kwvS82Deg4/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.3GQ56AqYvf/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fed077e0cc7b37b6073474d5c2b0b165c581a7434abb606b4837c1b0f997e6cd92c1fa68e390ead71916793d6cde3fba13de6d2c149e0e1e2452c18616b00994", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa24543e2e62863e39b3d9fe47e6dd1e2b189389d6e8dce847ebf9a1ccf919392298763808b447fb8e6fd0b824002c7988aacfd46391d3da8714760d367df05f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5402a1d6e7fb8ba49bbde56432b814753514a3ce185f4c1afc386207abfc91a2c0ec481eb43b61816e92016e50231d769794ad74aefe7c55dbb1e9e6a68f8e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e348caeef8e6d21fe04afdc72770ac96da3c76c0c77985220aad0109ba1b0db46c233ffad25aede48efc66891e46fe129650b754a6ebdfd493eef4d9244b78a"} build_url:https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/Q_bPeYeLS6e0_ttraCf9dQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fed077e0cc7b37b6073474d5c2b0b165c581a7434abb606b4837c1b0f997e6cd92c1fa68e390ead71916793d6cde3fba13de6d2c149e0e1e2452c18616b00994", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa24543e2e62863e39b3d9fe47e6dd1e2b189389d6e8dce847ebf9a1ccf919392298763808b447fb8e6fd0b824002c7988aacfd46391d3da8714760d367df05f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5402a1d6e7fb8ba49bbde56432b814753514a3ce185f4c1afc386207abfc91a2c0ec481eb43b61816e92016e50231d769794ad74aefe7c55dbb1e9e6a68f8e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e348caeef8e6d21fe04afdc72770ac96da3c76c0c77985220aad0109ba1b0db46c233ffad25aede48efc66891e46fe129650b754a6ebdfd493eef4d9244b78a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 14:10:02.287615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 14:10:02.288205) ========= 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.kwvS82Deg4/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.3GQ56AqYvf/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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.005289 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 14:10:02.339318) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 14:10:02.339936) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 14:10:02.340576) ========= ========= Total master_lag: 0.30 =========