builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0180 starttime: 1490303122.21 results: success (0) buildid: 20170323121323 builduid: 72f104392fe4494e9028257e263c982f revision: a786773148122f212b9335baaf89c5fb19ce5a58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 14:05:22.209432) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 14:05:22.209901) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 14:05:22.210182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 14:05:22.240278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 14:05:22.240638) ========= 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.WfQsPhESVB/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.UMsec9u6ZB/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-03-23 14:05:22-- 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% 50.9M=0s 2017-03-23 14:05:22 (50.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123314 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 14:05:22.389084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 14:05:22.389427) ========= 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.WfQsPhESVB/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.UMsec9u6ZB/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.025331 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 14:05:22.438510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 14:05:22.439409) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a786773148122f212b9335baaf89c5fb19ce5a58 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a786773148122f212b9335baaf89c5fb19ce5a58 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WfQsPhESVB/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.UMsec9u6ZB/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-03-23 14:05:22,524 truncating revision to first 12 chars 2017-03-23 14:05:22,525 Setting DEBUG logging. 2017-03-23 14:05:22,525 attempt 1/10 2017-03-23 14:05:22,525 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a78677314812?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 14:05:24,080 unpacking tar archive at: mozilla-beta-a78677314812/testing/mozharness/ program finished with exit code 0 elapsedTime=1.820113 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 14:05:24.284052) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 14:05:24.284374) ========= script_repo_revision: a786773148122f212b9335baaf89c5fb19ce5a58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 14:05:24.284763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 14:05:24.285030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 14:05:24.305583) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-23 14:05:24.305955) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WfQsPhESVB/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.UMsec9u6ZB/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 14:05:24 INFO - MultiFileLogger online at 20170323 14:05:24 in /builds/slave/test 14:05:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:05:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:05:24 INFO - {'append_to_log': False, 14:05:24 INFO - 'base_work_dir': '/builds/slave/test', 14:05:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:05:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:05:24 INFO - 'branch': 'Mozilla-Beta', 14:05:24 INFO - 'buildbot_json_path': 'buildprops.json', 14:05:24 INFO - 'config_files': ('talos/mac_config.py',), 14:05:24 INFO - 'default_actions': ('clobber', 14:05:24 INFO - 'read-buildbot-config', 14:05:24 INFO - 'download-and-extract', 14:05:24 INFO - 'populate-webroot', 14:05:24 INFO - 'create-virtualenv', 14:05:24 INFO - 'install', 14:05:24 INFO - 'run-tests'), 14:05:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:05:24 INFO - 'download_minidump_stackwalk': True, 14:05:24 INFO - 'download_symbols': 'ondemand', 14:05:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:05:24 INFO - 'tooltool.py': '/tools/tooltool.py', 14:05:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:05:24 INFO - '/tools/misc-python/virtualenv.py')}, 14:05:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:05:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:05:24 INFO - 'installer_path': 'installer.exe', 14:05:24 INFO - 'log_level': 'info', 14:05:24 INFO - 'log_name': 'talos', 14:05:24 INFO - 'log_to_console': True, 14:05:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:05:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:05:24 INFO - 'opt_config_files': (), 14:05:24 INFO - 'pip_index': False, 14:05:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:05:24 INFO - 'cmd': ('bash', 14:05:24 INFO - '-c', 14:05:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:05:24 INFO - 'enabled': True, 14:05:24 INFO - 'halt_on_failure': False, 14:05:24 INFO - 'name': 'check_screen_resolution'},), 14:05:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:05:24 INFO - 'cmd': ('bash', 14:05:24 INFO - '-c', 14:05:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:05:24 INFO - 'enabled': True, 14:05:24 INFO - 'halt_on_failure': False, 14:05:24 INFO - 'name': 'check_screen_resolution'},), 14:05:24 INFO - 'run_cmd_checks_enabled': True, 14:05:24 INFO - 'sps_profile': False, 14:05:24 INFO - 'sps_profile_interval': 0, 14:05:24 INFO - 'suite': 'dromaeojs', 14:05:24 INFO - 'system_bits': '32', 14:05:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:05:24 INFO - 'title': 't-yosemite-r7-0180', 14:05:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:05:24 INFO - 'use_talos_json': True, 14:05:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:05:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:05:24 INFO - 'work_dir': 'build'} 14:05:24 INFO - [mozharness: 2017-03-23 21:05:24.518534Z] Running clobber step. 14:05:24 INFO - Running pre-action listener: _resource_record_pre_action 14:05:24 INFO - Running main action method: clobber 14:05:24 INFO - rmtree: /builds/slave/test/build 14:05:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:05:28 INFO - Running post-action listener: _resource_record_post_action 14:05:28 INFO - [mozharness: 2017-03-23 21:05:28.171860Z] Finished clobber step (success) 14:05:28 INFO - [mozharness: 2017-03-23 21:05:28.172131Z] Running read-buildbot-config step. 14:05:28 INFO - Running pre-action listener: _resource_record_pre_action 14:05:28 INFO - Running main action method: read_buildbot_config 14:05:28 INFO - Using buildbot properties: 14:05:28 INFO - { 14:05:28 INFO - "project": "", 14:05:28 INFO - "product": "firefox", 14:05:28 INFO - "script_repo_revision": "production", 14:05:28 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:05:28 INFO - "repository": "", 14:05:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:05:28 INFO - "buildid": "20170323121323", 14:05:28 INFO - "pgo_build": "False", 14:05:28 INFO - "basedir": "/builds/slave/test", 14:05:28 INFO - "buildnumber": 9, 14:05:28 INFO - "slavename": "t-yosemite-r7-0180", 14:05:28 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:05:28 INFO - "platform": "yosemite_r7", 14:05:28 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:05:28 INFO - "branch": "mozilla-beta", 14:05:28 INFO - "repo_path": "releases/mozilla-beta", 14:05:28 INFO - "revision": "a786773148122f212b9335baaf89c5fb19ce5a58", 14:05:28 INFO - "stage_platform": "macosx64", 14:05:28 INFO - "builduid": "72f104392fe4494e9028257e263c982f", 14:05:28 INFO - "slavebuilddir": "test" 14:05:28 INFO - } 14:05:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 14:05:28 INFO - Running post-action listener: _resource_record_post_action 14:05:28 INFO - [mozharness: 2017-03-23 21:05:28.178115Z] Finished read-buildbot-config step (success) 14:05:28 INFO - [mozharness: 2017-03-23 21:05:28.178322Z] Running download-and-extract step. 14:05:28 INFO - Running pre-action listener: _resource_record_pre_action 14:05:28 INFO - Running main action method: download_and_extract 14:05:28 INFO - mkdir: /builds/slave/test/build/tests 14:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:28 INFO - trying https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 14:05:28 INFO - Downloading https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 14:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 14:05:29 INFO - Downloaded 1165 bytes. 14:05:29 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 14:05:29 INFO - Using the following test package requirements: 14:05:29 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 14:05:29 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:29 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 14:05:29 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:29 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 14:05:29 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:05:29 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:29 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 14:05:29 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 14:05:29 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:29 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 14:05:29 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:29 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 14:05:29 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:29 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 14:05:29 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:05:29 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 14:05:29 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 14:05:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 14:05:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 14:05:29 INFO - Fetch https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 14:05:31 INFO - Expected file size: 16108232 14:05:31 INFO - Obtained file size: 16108232 14:05:37 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:05:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 14:05:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 14:05:37 INFO - Fetch https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 14:05:38 INFO - Expected file size: 16108232 14:05:38 INFO - Obtained file size: 16108232 14:05:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 14:05:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 14:05:45 INFO - Fetch https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 14:05:46 INFO - Expected file size: 14403663 14:05:46 INFO - Obtained file size: 14403663 14:05: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')]} 14:05:46 INFO - trying https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:05:46 INFO - Downloading https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 14:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 14:05:49 INFO - Downloaded 58730373 bytes. 14:05:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:05:49 INFO - mkdir: /builds/slave/test/properties 14:05:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:05:49 INFO - Writing to file /builds/slave/test/properties/build_url 14:05:49 INFO - Contents: 14:05:49 INFO - build_url:https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:05:50 INFO - Running post-action listener: _resource_record_post_action 14:05:50 INFO - Running post-action listener: set_extra_try_arguments 14:05:50 INFO - [mozharness: 2017-03-23 21:05:50.617465Z] Finished download-and-extract step (success) 14:05:50 INFO - [mozharness: 2017-03-23 21:05:50.617568Z] Running populate-webroot step. 14:05:50 INFO - Running pre-action listener: _resource_record_pre_action 14:05:50 INFO - Running main action method: populate_webroot 14:05:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:05:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:05:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:05:50 INFO - '--tppagecycles', 14:05:50 INFO - '7'], 14:05:50 INFO - 'tests': ['tsvgm']}}, 14:05:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:05:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:05:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:05:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:05:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:05:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:05:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:05:50 INFO - 'talos_options': ['--disable-e10s'], 14:05:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:05:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:05:50 INFO - 'talos_options': ['--disable-e10s'], 14:05:50 INFO - 'tests': ['damp', 'tps']}, 14:05:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:05:50 INFO - 'tests': ['damp', 'tps']}, 14:05:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:05:50 INFO - 'tests': ['dromaeo_dom']}, 14:05:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:05:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:05:50 INFO - 'tests': ['basic_compositor_video']}, 14:05:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:05:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:05:50 INFO - 'tests': ['a11yr', 14:05:50 INFO - 'ts_paint', 14:05:50 INFO - 'tpaint', 14:05:50 INFO - 'sessionrestore', 14:05:50 INFO - 'sessionrestore_no_auto_restore', 14:05:50 INFO - 'tabpaint']}, 14:05:50 INFO - 'other-e10s': {'tests': ['a11yr', 14:05:50 INFO - 'ts_paint', 14:05:50 INFO - 'tpaint', 14:05:50 INFO - 'sessionrestore', 14:05:50 INFO - 'sessionrestore_no_auto_restore', 14:05:50 INFO - 'tabpaint']}, 14:05:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:05:50 INFO - 'ts_paint', 14:05:50 INFO - 'tpaint', 14:05:50 INFO - 'sessionrestore', 14:05:50 INFO - 'sessionrestore_no_auto_restore', 14:05:50 INFO - 'tabpaint']}, 14:05:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:05:50 INFO - 'ts_paint', 14:05:50 INFO - 'tpaint', 14:05:50 INFO - 'sessionrestore', 14:05:50 INFO - 'sessionrestore_no_auto_restore', 14:05:50 INFO - 'tabpaint']}, 14:05:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:05:50 INFO - 'tests': ['a11yr', 14:05:50 INFO - 'ts_paint', 14:05:50 INFO - 'tpaint', 14:05:50 INFO - 'sessionrestore', 14:05:50 INFO - 'sessionrestore_no_auto_restore', 14:05:50 INFO - 'tabpaint']}, 14:05:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:05:50 INFO - 'tests': ['a11yr', 14:05:50 INFO - 'ts_paint', 14:05:50 INFO - 'tpaint', 14:05:50 INFO - 'sessionrestore', 14:05:50 INFO - 'sessionrestore_no_auto_restore', 14:05:50 INFO - 'tabpaint']}, 14:05:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:05:50 INFO - 'tests': ['tsvgx', 14:05:50 INFO - 'tsvgr_opacity', 14:05:50 INFO - 'tart', 14:05:50 INFO - 'tscrollx', 14:05:50 INFO - 'cart', 14:05:50 INFO - 'tsvg_static']}, 14:05:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:05:50 INFO - 'tsvgr_opacity', 14:05:50 INFO - 'tart', 14:05:50 INFO - 'tscrollx', 14:05:50 INFO - 'cart', 14:05:50 INFO - 'tsvg_static']}, 14:05:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:05:50 INFO - 'talos_options': ['--disable-e10s'], 14:05:50 INFO - 'tests': ['tp5o']}, 14:05:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:05:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:05:50 INFO - 'talos_options': ['--disable-e10s', 14:05:50 INFO - '--xperf_path', 14:05:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:50 INFO - 'tests': ['tp5n']}, 14:05:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:05:50 INFO - 'talos_options': ['--xperf_path', 14:05:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:50 INFO - 'tests': ['tp5n']}}, 14:05:50 INFO - 'talos.zip': {'path': '', 14:05:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:05:50 INFO - Running post-action listener: _resource_record_post_action 14:05:50 INFO - [mozharness: 2017-03-23 21:05:50.636429Z] Finished populate-webroot step (success) 14:05:50 INFO - [mozharness: 2017-03-23 21:05:50.636562Z] Running create-virtualenv step. 14:05:50 INFO - Running pre-action listener: _resource_record_pre_action 14:05:50 INFO - Running main action method: create_virtualenv 14:05:50 INFO - Creating virtualenv /builds/slave/test/build/venv 14:05:50 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 14:05:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:05:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:05:50 INFO - Using real prefix '/tools/python27' 14:05:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:05:51 INFO - Installing distribute.............................................................................................................................................................................................done. 14:05:54 INFO - Installing pip.................done. 14:05:54 INFO - Return code: 0 14:05:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:05:54 INFO - Reading from file tmpfile_stdout 14:05:54 INFO - Output received: 14:05:54 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) 14:05:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:54 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 0x107805b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98dbb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e3d30>, '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 0x10750adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075d8be8>, '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.WfQsPhESVB/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.UMsec9u6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 14:05:54 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 14:05:54 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 14:05:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WfQsPhESVB/Render', 14:05:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:54 INFO - 'HOME': '/Users/cltbld', 14:05:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:54 INFO - 'LOGNAME': 'cltbld', 14:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:54 INFO - 'MOZ_NO_REMOTE': '1', 14:05:54 INFO - 'NO_EM_RESTART': '1', 14:05:54 INFO - 'PAGER': '/bin/cat', 14:05:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:54 INFO - 'PWD': '/builds/slave/test', 14:05:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:54 INFO - 'SHELL': '/bin/bash', 14:05:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UMsec9u6ZB/Listeners', 14:05:54 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 14:05:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:54 INFO - 'USER': 'cltbld', 14:05:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:54 INFO - 'XPC_FLAGS': '0x0', 14:05:54 INFO - 'XPC_SERVICE_NAME': '0', 14:05:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:54 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 14:05:54 INFO - Cleaning up... 14:05:54 INFO - Return code: 0 14:05:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:54 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 0x107805b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98dbb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e3d30>, '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 0x10750adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075d8be8>, '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.WfQsPhESVB/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.UMsec9u6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 14:05:54 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 14:05:54 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 14:05:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WfQsPhESVB/Render', 14:05:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:54 INFO - 'HOME': '/Users/cltbld', 14:05:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:54 INFO - 'LOGNAME': 'cltbld', 14:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:54 INFO - 'MOZ_NO_REMOTE': '1', 14:05:54 INFO - 'NO_EM_RESTART': '1', 14:05:54 INFO - 'PAGER': '/bin/cat', 14:05:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:54 INFO - 'PWD': '/builds/slave/test', 14:05:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:54 INFO - 'SHELL': '/bin/bash', 14:05:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UMsec9u6ZB/Listeners', 14:05:54 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 14:05:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:54 INFO - 'USER': 'cltbld', 14:05:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:54 INFO - 'XPC_FLAGS': '0x0', 14:05:54 INFO - 'XPC_SERVICE_NAME': '0', 14:05:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:55 INFO - Downloading/unpacking psutil>=3.1.1 14:05:55 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 14:05:55 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 14:05:55 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 14:05:55 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 14:05:55 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 14:05:55 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 14:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:05:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:58 INFO - Installing collected packages: psutil 14:05:58 INFO - Running setup.py install for psutil 14:05:58 INFO - building 'psutil._psutil_osx' extension 14:05:58 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 14:05:59 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 14:05:59 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 14:05:59 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 14:05:59 INFO - building 'psutil._psutil_posix' extension 14:05:59 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 14:05:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:05:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:05:59 INFO - ^ 14:05:59 INFO - 1 warning generated. 14:05:59 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 14:05:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:59 INFO - Successfully installed psutil 14:05:59 INFO - Cleaning up... 14:05:59 INFO - Return code: 0 14:05:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:59 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 0x107805b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98dbb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e3d30>, '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 0x10750adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075d8be8>, '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.WfQsPhESVB/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.UMsec9u6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 14:05:59 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 14:05:59 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 14:05:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WfQsPhESVB/Render', 14:05:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:59 INFO - 'HOME': '/Users/cltbld', 14:05:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:59 INFO - 'LOGNAME': 'cltbld', 14:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:59 INFO - 'MOZ_NO_REMOTE': '1', 14:05:59 INFO - 'NO_EM_RESTART': '1', 14:05:59 INFO - 'PAGER': '/bin/cat', 14:05:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:59 INFO - 'PWD': '/builds/slave/test', 14:05:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:59 INFO - 'SHELL': '/bin/bash', 14:05:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UMsec9u6ZB/Listeners', 14:05:59 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 14:05:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:59 INFO - 'USER': 'cltbld', 14:05:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:59 INFO - 'XPC_FLAGS': '0x0', 14:05:59 INFO - 'XPC_SERVICE_NAME': '0', 14:05:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:05:59 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 14:05:59 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 14:05:59 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 14:05:59 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 14:05:59 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 14:05:59 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 14:06:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:06:02 INFO - Installing collected packages: mozsystemmonitor 14:06:02 INFO - Running setup.py install for mozsystemmonitor 14:06:02 INFO - Successfully installed mozsystemmonitor 14:06:02 INFO - Cleaning up... 14:06:02 INFO - Return code: 0 14:06:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107805b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98dbb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e3d30>, '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 0x10750adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075d8be8>, '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.WfQsPhESVB/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.UMsec9u6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 14:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:06:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WfQsPhESVB/Render', 14:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:02 INFO - 'HOME': '/Users/cltbld', 14:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:02 INFO - 'LOGNAME': 'cltbld', 14:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:02 INFO - 'MOZ_NO_REMOTE': '1', 14:06:02 INFO - 'NO_EM_RESTART': '1', 14:06:02 INFO - 'PAGER': '/bin/cat', 14:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:02 INFO - 'PWD': '/builds/slave/test', 14:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:02 INFO - 'SHELL': '/bin/bash', 14:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UMsec9u6ZB/Listeners', 14:06:02 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 14:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:02 INFO - 'USER': 'cltbld', 14:06:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:02 INFO - 'XPC_FLAGS': '0x0', 14:06:02 INFO - 'XPC_SERVICE_NAME': '0', 14:06:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:02 INFO - Downloading/unpacking jsonschema==2.5.1 14:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:06:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:05 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 14:06:05 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 14:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:06 INFO - Downloading functools32-3.2.3-2.tar.gz 14:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:06:06 INFO - warning: no files found matching '*.txt' 14:06:06 INFO - no previously-included directories found matching 'build' 14:06:06 INFO - no previously-included directories found matching 'dist' 14:06:06 INFO - no previously-included directories found matching '.git*' 14:06:06 INFO - Installing collected packages: jsonschema, functools32 14:06:06 INFO - Running setup.py install for functools32 14:06:06 INFO - warning: no files found matching '*.txt' 14:06:06 INFO - no previously-included directories found matching 'build' 14:06:06 INFO - no previously-included directories found matching 'dist' 14:06:06 INFO - no previously-included directories found matching '.git*' 14:06:06 INFO - Successfully installed jsonschema functools32 14:06:06 INFO - Cleaning up... 14:06:06 INFO - Return code: 0 14:06:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:06:06 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')]} 14:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:06 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')]} 14:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:06 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 0x107805b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98dbb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e3d30>, '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 0x10750adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075d8be8>, '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.WfQsPhESVB/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.UMsec9u6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 14:06:06 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 14:06:06 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 14:06:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WfQsPhESVB/Render', 14:06:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:06 INFO - 'HOME': '/Users/cltbld', 14:06:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:06 INFO - 'LOGNAME': 'cltbld', 14:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:06 INFO - 'MOZ_NO_REMOTE': '1', 14:06:06 INFO - 'NO_EM_RESTART': '1', 14:06:06 INFO - 'PAGER': '/bin/cat', 14:06:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:06 INFO - 'PWD': '/builds/slave/test', 14:06:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:06 INFO - 'SHELL': '/bin/bash', 14:06:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UMsec9u6ZB/Listeners', 14:06:06 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 14:06:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:06 INFO - 'USER': 'cltbld', 14:06:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:06 INFO - 'XPC_FLAGS': '0x0', 14:06:06 INFO - 'XPC_SERVICE_NAME': '0', 14:06:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:06:06 INFO - Cleaning up... 14:06:06 INFO - Return code: 0 14:06:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:06:06 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')]} 14:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:06 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')]} 14:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:06 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 0x107805b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98dbb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e3d30>, '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 0x10750adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075d8be8>, '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.WfQsPhESVB/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.UMsec9u6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 14:06:06 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 14:06:06 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 14:06:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WfQsPhESVB/Render', 14:06:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:06 INFO - 'HOME': '/Users/cltbld', 14:06:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:06 INFO - 'LOGNAME': 'cltbld', 14:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:06 INFO - 'MOZ_NO_REMOTE': '1', 14:06:06 INFO - 'NO_EM_RESTART': '1', 14:06:06 INFO - 'PAGER': '/bin/cat', 14:06:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:06 INFO - 'PWD': '/builds/slave/test', 14:06:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:06 INFO - 'SHELL': '/bin/bash', 14:06:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UMsec9u6ZB/Listeners', 14:06:06 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 14:06:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:06 INFO - 'USER': 'cltbld', 14:06:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:06 INFO - 'XPC_FLAGS': '0x0', 14:06:06 INFO - 'XPC_SERVICE_NAME': '0', 14:06:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:06 INFO - Downloading/unpacking blobuploader==1.2.4 14:06:06 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 14:06:06 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 14:06:06 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 14:06:06 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 14:06:06 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 14:06:06 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 14:06:09 INFO - Downloading blobuploader-1.2.4.tar.gz 14:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:06:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:06:09 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 14:06:09 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 14:06:09 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 14:06:09 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 14:06:09 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 14:06:09 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 14:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:06:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:11 INFO - Downloading docopt-0.6.1.tar.gz 14:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:06:11 INFO - Installing collected packages: blobuploader, requests, docopt 14:06:11 INFO - Running setup.py install for blobuploader 14:06:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:06:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:06:11 INFO - Running setup.py install for requests 14:06:11 INFO - Running setup.py install for docopt 14:06:11 INFO - Successfully installed blobuploader requests docopt 14:06:11 INFO - Cleaning up... 14:06:12 INFO - Return code: 0 14:06:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:12 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')]} 14:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:12 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')]} 14:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:12 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 0x107805b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98dbb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e3d30>, '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 0x10750adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075d8be8>, '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.WfQsPhESVB/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.UMsec9u6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 14:06:12 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 14:06:12 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 14:06:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WfQsPhESVB/Render', 14:06:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:12 INFO - 'HOME': '/Users/cltbld', 14:06:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:12 INFO - 'LOGNAME': 'cltbld', 14:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:12 INFO - 'MOZ_NO_REMOTE': '1', 14:06:12 INFO - 'NO_EM_RESTART': '1', 14:06:12 INFO - 'PAGER': '/bin/cat', 14:06:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:12 INFO - 'PWD': '/builds/slave/test', 14:06:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:12 INFO - 'SHELL': '/bin/bash', 14:06:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UMsec9u6ZB/Listeners', 14:06:12 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 14:06:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:12 INFO - 'USER': 'cltbld', 14:06:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:12 INFO - 'XPC_FLAGS': '0x0', 14:06:12 INFO - 'XPC_SERVICE_NAME': '0', 14:06:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ELPAc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-zyM3kA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-2qE33R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gGV2QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Y2Dsxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ah4TZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-E3HAih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-VbILz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-8Pkmd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-NuZCU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-9KwHmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-R3OhZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Yu5oJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-PGjwjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-aRM1rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gZiBgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:14 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-XITmOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:06:14 INFO - Running setup.py install for manifestparser 14:06:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:06:14 INFO - Running setup.py install for mozcrash 14:06:14 INFO - Running setup.py install for mozdebug 14:06:14 INFO - Running setup.py install for mozdevice 14:06:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:06:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:06:14 INFO - Running setup.py install for mozfile 14:06:14 INFO - Running setup.py install for mozhttpd 14:06:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:06:15 INFO - Running setup.py install for mozinfo 14:06:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:06:15 INFO - Running setup.py install for mozInstall 14:06:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:06:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:06:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:06:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:06:15 INFO - Running setup.py install for mozleak 14:06:15 INFO - Running setup.py install for mozlog 14:06:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:06:15 INFO - Running setup.py install for moznetwork 14:06:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:06:15 INFO - Running setup.py install for mozprocess 14:06:15 INFO - Running setup.py install for mozprofile 14:06:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:06:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:06:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:06:16 INFO - Running setup.py install for mozrunner 14:06:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:06:16 INFO - Running setup.py install for mozscreenshot 14:06:16 INFO - Running setup.py install for moztest 14:06:16 INFO - Running setup.py install for mozversion 14:06:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:06:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:06:16 INFO - Cleaning up... 14:06:16 INFO - Return code: 0 14:06:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:16 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')]} 14:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:16 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')]} 14:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:16 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 0x107805b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98dbb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e3d30>, '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 0x10750adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075d8be8>, '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.WfQsPhESVB/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.UMsec9u6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 14:06:16 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 14:06:16 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 14:06:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WfQsPhESVB/Render', 14:06:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:16 INFO - 'HOME': '/Users/cltbld', 14:06:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:16 INFO - 'LOGNAME': 'cltbld', 14:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:16 INFO - 'MOZ_NO_REMOTE': '1', 14:06:16 INFO - 'NO_EM_RESTART': '1', 14:06:16 INFO - 'PAGER': '/bin/cat', 14:06:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:16 INFO - 'PWD': '/builds/slave/test', 14:06:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:16 INFO - 'SHELL': '/bin/bash', 14:06:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UMsec9u6ZB/Listeners', 14:06:16 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 14:06:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:16 INFO - 'USER': 'cltbld', 14:06:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:16 INFO - 'XPC_FLAGS': '0x0', 14:06:16 INFO - 'XPC_SERVICE_NAME': '0', 14:06:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:17 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-SxtCPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:17 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)) 14:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:17 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-K1Ruql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:17 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)) 14:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:17 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-zljrO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:17 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)) 14:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:17 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-LTfgfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:17 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)) 14:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:17 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-BlThXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:17 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)) 14:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:17 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-oAGVZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:17 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)) 14:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:17 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-mBBGq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:17 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)) 14:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:17 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-NYBYFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:17 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)) 14:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:17 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-pL5eEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:17 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)) 14:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:17 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-SuJ5R0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:18 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)) 14:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:18 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-LMSuSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:18 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)) 14:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:18 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-7_YwQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:18 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)) 14:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:18 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-2Z3SjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:18 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)) 14:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:18 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-mr2pbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:18 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)) 14:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:18 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-FC50di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:18 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)) 14:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:18 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-aR_RrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:18 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)) 14:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:18 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-b5Cwdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:18 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)) 14:06:18 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)) 14:06:18 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)) 14:06:18 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)) 14:06:18 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)) 14:06:18 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)) 14:06:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:21 INFO - Downloading blessings-1.6.tar.gz 14:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:06:21 INFO - Installing collected packages: blessings 14:06:21 INFO - Running setup.py install for blessings 14:06:21 INFO - Successfully installed blessings 14:06:21 INFO - Cleaning up... 14:06:21 INFO - Return code: 0 14:06:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:06:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:22 INFO - Reading from file tmpfile_stdout 14:06:22 INFO - Current package versions: 14:06:22 INFO - blessings == 1.6 14:06:22 INFO - blobuploader == 1.2.4 14:06:22 INFO - docopt == 0.6.1 14:06:22 INFO - functools32 == 3.2.3-2 14:06:22 INFO - jsonschema == 2.5.1 14:06:22 INFO - manifestparser == 1.1 14:06:22 INFO - mozInstall == 1.12 14:06:22 INFO - mozcrash == 1.0 14:06:22 INFO - mozdebug == 0.1 14:06:22 INFO - mozdevice == 0.49 14:06:22 INFO - mozfile == 1.2 14:06:22 INFO - mozhttpd == 0.7 14:06:22 INFO - mozinfo == 0.9 14:06:22 INFO - mozleak == 0.1 14:06:22 INFO - mozlog == 3.4 14:06:22 INFO - moznetwork == 0.27 14:06:22 INFO - mozprocess == 0.24 14:06:22 INFO - mozprofile == 0.28 14:06:22 INFO - mozrunner == 6.13 14:06:22 INFO - mozscreenshot == 0.1 14:06:22 INFO - mozsystemmonitor == 0.3 14:06:22 INFO - moztest == 0.8 14:06:22 INFO - mozversion == 1.4 14:06:22 INFO - psutil == 3.1.1 14:06:22 INFO - requests == 1.2.3 14:06:22 INFO - wsgiref == 0.1.2 14:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:22 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 0x107805b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98dbb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e3d30>, '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 0x10750adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075d8be8>, '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.WfQsPhESVB/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.UMsec9u6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 14:06:22 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 14:06:22 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 14:06:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WfQsPhESVB/Render', 14:06:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:22 INFO - 'HOME': '/Users/cltbld', 14:06:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:22 INFO - 'LOGNAME': 'cltbld', 14:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:22 INFO - 'MOZ_NO_REMOTE': '1', 14:06:22 INFO - 'NO_EM_RESTART': '1', 14:06:22 INFO - 'PAGER': '/bin/cat', 14:06:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:22 INFO - 'PWD': '/builds/slave/test', 14:06:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:22 INFO - 'SHELL': '/bin/bash', 14:06:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UMsec9u6ZB/Listeners', 14:06:22 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 14:06:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:22 INFO - 'USER': 'cltbld', 14:06:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:22 INFO - 'XPC_FLAGS': '0x0', 14:06:22 INFO - 'XPC_SERVICE_NAME': '0', 14:06:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:22 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)) 14:06:22 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)) 14:06:22 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)) 14:06:22 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)) 14:06:22 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)) 14:06:22 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)) 14:06:22 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)) 14:06:22 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)) 14:06:22 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)) 14:06:22 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)) 14:06:22 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)) 14:06:22 INFO - Cleaning up... 14:06:22 INFO - Return code: 0 14:06:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107805b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107808768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98dbb6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075e3d30>, '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 0x10750adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075d8be8>, '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.WfQsPhESVB/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.UMsec9u6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 14:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:06:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WfQsPhESVB/Render', 14:06:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:22 INFO - 'HOME': '/Users/cltbld', 14:06:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:22 INFO - 'LOGNAME': 'cltbld', 14:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:22 INFO - 'MOZ_NO_REMOTE': '1', 14:06:22 INFO - 'NO_EM_RESTART': '1', 14:06:22 INFO - 'PAGER': '/bin/cat', 14:06:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:22 INFO - 'PWD': '/builds/slave/test', 14:06:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:22 INFO - 'SHELL': '/bin/bash', 14:06:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UMsec9u6ZB/Listeners', 14:06:22 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 14:06:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:22 INFO - 'USER': 'cltbld', 14:06:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:22 INFO - 'XPC_FLAGS': '0x0', 14:06:22 INFO - 'XPC_SERVICE_NAME': '0', 14:06:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:06:22 INFO - Cleaning up... 14:06:22 INFO - Return code: 0 14:06:22 INFO - Running post-action listener: _resource_record_post_action 14:06:22 INFO - Running post-action listener: _start_resource_monitoring 14:06:22 INFO - Starting resource monitoring. 14:06:22 INFO - [mozharness: 2017-03-23 21:06:22.718278Z] Finished create-virtualenv step (success) 14:06:22 INFO - [mozharness: 2017-03-23 21:06:22.719263Z] Running install step. 14:06:22 INFO - Running pre-action listener: _resource_record_pre_action 14:06:22 INFO - Running main action method: install 14:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:22 INFO - Reading from file tmpfile_stdout 14:06:22 INFO - Detecting whether we're running mozinstall >=1.0... 14:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:06:23 INFO - Reading from file tmpfile_stdout 14:06:23 INFO - Output received: 14:06:23 INFO - Usage: mozinstall [options] installer 14:06:23 INFO - Options: 14:06:23 INFO - -h, --help show this help message and exit 14:06:23 INFO - -d DEST, --destination=DEST 14:06:23 INFO - Directory to install application into. [default: 14:06:23 INFO - "/builds/slave/test"] 14:06:23 INFO - --app=APP Application being installed. [default: firefox] 14:06:23 INFO - mkdir: /builds/slave/test/build/application 14:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:06:37 INFO - Reading from file tmpfile_stdout 14:06:37 INFO - Output received: 14:06:37 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:06:37 INFO - Running post-action listener: _resource_record_post_action 14:06:37 INFO - [mozharness: 2017-03-23 21:06:37.881142Z] Finished install step (success) 14:06:37 INFO - [mozharness: 2017-03-23 21:06:37.881267Z] Running run-tests step. 14:06:37 INFO - Running pre-action listener: _resource_record_pre_action 14:06:37 INFO - Running main action method: run_tests 14:06:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:06:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:06:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:06:37 INFO - 2017-03-23 14:06:37.896 screenresolution[6963:125964] starting screenresolution argv=screenresolution get 14:06:37 INFO - 2017-03-23 14:06:37.898 screenresolution[6963:125964] Display 0: 1600x1200x32@60 14:06:37 INFO - 2017-03-23 14:06:37.904 screenresolution[6964:125966] starting screenresolution argv=screenresolution list 14:06:37 INFO - Available Modes on Display 0 14:06:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:06:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:06:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:06:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:06:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:06:38 INFO - Intel Iris: 14:06:38 INFO - Chipset Model: Intel Iris 14:06:38 INFO - Type: GPU 14:06:38 INFO - Bus: Built-In 14:06:38 INFO - VRAM (Dynamic, Max): 1536 MB 14:06:38 INFO - Vendor: Intel (0x8086) 14:06:38 INFO - Device ID: 0x0a2e 14:06:38 INFO - Revision ID: 0x0009 14:06:38 INFO - Displays: 14:06:38 INFO - Display: 14:06:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:06:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:06:38 INFO - Display Serial Number: 1600x1200 60 14:06:38 INFO - Main Display: Yes 14:06:38 INFO - Mirror: Off 14:06:38 INFO - Online: Yes 14:06:38 INFO - Rotation: Supported 14:06:38 INFO - Return code: 0 14:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:06:38 INFO - Python 2.7.3 14:06:38 INFO - Return code: 0 14:06:38 INFO - grabbing minidump binary from tooltool 14:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:38 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 0x1075e3d30>, '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 0x10750adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075d8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:06:38 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 14:06:38 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 14:06:38 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 14:06:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:06:38 INFO - Return code: 0 14:06:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:06:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:06:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:06:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:06:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--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 14:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --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 14:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WfQsPhESVB/Render', 14:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:38 INFO - 'HOME': '/Users/cltbld', 14:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:38 INFO - 'LOGNAME': 'cltbld', 14:06:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:06:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:38 INFO - 'MOZ_NO_REMOTE': '1', 14:06:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:06:38 INFO - 'NO_EM_RESTART': '1', 14:06:38 INFO - 'PAGER': '/bin/cat', 14:06:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:38 INFO - 'PWD': '/builds/slave/test', 14:06:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:38 INFO - 'SHELL': '/bin/bash', 14:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UMsec9u6ZB/Listeners', 14:06:38 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 14:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:38 INFO - 'USER': 'cltbld', 14:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:38 INFO - 'XPC_FLAGS': '0x0', 14:06:38 INFO - 'XPC_SERVICE_NAME': '0', 14:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--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 14:06:38 INFO - mozversion application_buildid: 20170323121323 14:06:38 INFO - mozversion application_changeset: a786773148122f212b9335baaf89c5fb19ce5a58 14:06:38 INFO - mozversion application_display_name: Firefox 14:06:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:06:38 INFO - mozversion application_name: Firefox 14:06:38 INFO - mozversion application_remotingname: firefox 14:06:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:06:38 INFO - mozversion application_vendor: Mozilla 14:06:38 INFO - mozversion application_version: 53.0 14:06:38 INFO - mozversion platform_buildid: 20170323121323 14:06:38 INFO - mozversion platform_changeset: a786773148122f212b9335baaf89c5fb19ce5a58 14:06:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:06:38 INFO - mozversion platform_version: 53.0 14:06:38 INFO - using testdate: 1490303198 14:06:38 INFO - actual date: 1490303198 14:06:38 INFO - starting webserver on 'localhost:57840' 14:06:38 INFO - SUITE-START | Running 2 tests 14:06:38 INFO - TEST-START | dromaeo_css 14:06:38 INFO - operating with platform_type : mac_ 14:06:38 INFO - Initialising browser for dromaeo_css test... 14:06:38 INFO - TEST-INFO | started process 6974 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpUjNJa9/profile http://localhost:57840/getInfo.html) 14:06:41 INFO - PROCESS | 6974 | __metrics Screen width/height:1600/1200 14:06:41 INFO - PROCESS | 6974 | colorDepth:24 14:06:41 INFO - PROCESS | 6974 | Browser inner width/height: 1024/689 14:06:41 INFO - PROCESS | 6974 | __metrics 14:06:41 INFO - PROCESS | 6974 | 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:06:41 INFO - PROCESS | 6974 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:06:41 INFO - TEST-INFO | 6974: exit 0 14:06:41 INFO - Browser initialized. 14:06:41 INFO - Running cycle 1/1 for dromaeo_css test... 14:06:41 INFO - TEST-INFO | started process 6977 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpUjNJa9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:53 INFO - PROCESS | 6977 | RSS: Main: 163340288 14:06:53 INFO - PROCESS | 6977 | 14:09:57 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:57840/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57840/tests/dromaeo/cssquery-ext.html) 14:09:58 INFO - PROCESS | 6977 | RSS: Main: 297787392 14:09:58 INFO - PROCESS | 6977 | 14:13:01 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:57840/tests/dromaeo/cssquery-ext.html (next: http://localhost:57840/tests/dromaeo/cssquery-jquery.html) 14:13:02 INFO - PROCESS | 6977 | RSS: Main: 304533504 14:13:02 INFO - PROCESS | 6977 | 14:16:04 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:57840/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57840/tests/dromaeo/cssquery-mootools.html) 14:16:04 INFO - PROCESS | 6977 | RSS: Main: 284073984 14:16:04 INFO - PROCESS | 6977 | 14:19:07 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:57840/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57840/tests/dromaeo/cssquery-prototype.html) 14:19:07 INFO - PROCESS | 6977 | RSS: Main: 293072896 14:19:07 INFO - PROCESS | 6977 | 14:22:11 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:57840/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57840/tests/dromaeo/cssquery-yui.html) 14:22:11 INFO - PROCESS | 6977 | RSS: Main: 274010112 14:22:11 INFO - PROCESS | 6977 | 14:25:14 INFO - PROCESS | 6977 | Cycle 1(1): loaded http://localhost:57840/tests/dromaeo/cssquery-yui.html (next: http://localhost:57840/tests/dromaeo/cssquery-dojo.html) 14:25:15 INFO - PROCESS | 6977 | RSS: Main: 375119872 14:25:15 INFO - PROCESS | 6977 | 14:25:15 INFO - PROCESS | 6977 | __start_tp_report 14:25:15 INFO - PROCESS | 6977 | _x_x_mozilla_page_load 14:25:15 INFO - PROCESS | 6977 | _x_x_mozilla_page_load_details 14:25:15 INFO - PROCESS | 6977 | |i|pagename|runs| 14:25:15 INFO - PROCESS | 6977 | |0;dojo.html;3394.5587073680417;3404.13194635368;3422.863085476581;3422.9828850855743;3492.423750081237;4814.638902082344;5777.393373695759;5817.272840894888;5824.854378640536;5833.82498525045;5811.27359080115;5906.734196961136;5908.940910590893;5911.733971971261;5933.792317268896;5214.270002199695;5278.102722537178;5289.709066001368;5298.178782288752;5339.466053394668;5221.921671174935;5232;5233.0580495510985;5369.301990741198;5385.596080293974;5318.680879147263;5320;5337.3061502004875;5342.519173274404;5391.245225668409;5350.866228344303;5378.865528361783;5381.48875856793;5384.838454846361;5385.703786291752;5161.7161056141895;5230.895382092337;5304.628675992643;5314.867128321785;5353.38436079848;5673.262475878109;5750.079987202028;5796.50729687977;5806.042003069489;5821.970890145564;6194.721237544276;6204.441600255954;6215.036669316263;6226.252849658024;6253.155823963798;6224.564280500367;6294.402031806971;6301.6219026858535;6310.368963103699;6317.87364252717;5863.501602363847;5917.852053698606;5996.190514280604;6008.879822403527;6076.0278355462915;6345.428911397997;6399.9360006400275;6410.326915673881;6411.743530258831;6425.1968503937005;6252.280987686383;6263.091851681481;6264.342244064399;6275.152854364694;6279.874402511924;6173.41352571505;6185.536084793658;6209.192804935329;6271.466925311308;6276.717547710364;6182.258129024546;6190.876182476325;6214.098955651405;6227.906581401283;6252.468540174136;6173.59871608344;6192.411720886508;6201.162843016225;6202.72087756043;6222.502199824094;4963.751812409365;5101.387833460009;5111.795528178905;5118.334616499831;5136.666116702402;4526.411566496335;4530.977345113253;4579.725216486955;4588.174128656874;4594.563516465931;6054.364291749391;6076.878462430726;6078.848028799315;6082.148499210114;6113.358097399798;6266.122742816009;6287.9056814147825;6329.8734025320155;6331.873362532723;6342.207224096988;5819.563532735062;5822.505087067562;5851.444112809277;6001.729922153513;6060.848478788065;5516.227728118067;5524.861878453071;5527.364353099445;5529.142982837586;5535.391106978229;6331.841703957346;6337.366263373534;6337.904931426125;6346.365363463709;6383.553151279366;6202.131701561695;6205.2553693557065;6307.558470906993;6312.242530896322;6321.652309122858;6372.968135159294;6494.64279464634;6523.67381630907;6529.118568993125;6537.5750576212395;6174.845628859135;6226.221722284715;6232.314445410911;6237.656928868956;6252.968735156295;6171.537134714825;6206.534509911865;6224.470919971853;6293.402126797947;6323.304436511888;6087.178230938766;6250.968745156245;6254.937450625435;6269.780557680459;6305.464035557029;6143.201383820075;6269.059641053878;6291.307956124731;6294.937050629435;6342.080398342307;5092.465291144525;6040.788572399945;6137.478314343331;6149.907751383822;6207.720652570555;6244.1570387997035;6253.374662533893;6256.812295631138;6273.247210334789;6291.937080629135;6146.016637338004;6150.04674275488;6190.133381326708;6197.349278325892;6207.16203312547 14:25:15 INFO - PROCESS | 6977 | |1;ext.html;480.8581468466802;504.04735050754056;518.9040027594895;533.9626226164168;534.2120372450634;32883.177920552;33904.830475847644;33952.49071263933;34066.977990660285;42516;45014.0997180057;45428;45466.31800522995;45542.77228613853;45687.62937111892;9548.522573871296;9673.758156046084;9688.224942004623;9688.224942004623;9777.90222097777;9065.818683626323;9266.258699304039;9537.523123843815;9689.660861869836;11628.476718547685;11474.48364823585;11652.951234388904;11745.236559623598;11750.941245293761;11821;11722.58970936013;11806.7638647227;11875.940620296844;11882.049436045096;11907.94046029773;11742.412879355998;11786.705332366759;11786.941065294619;11788.410579471078;11802.232854864405;41819.745407637514;42028;42054;42111.1577768446;42166.15667686629;4063.9796801015805;4094.222097801438;4119.588041195856;4133.565975572552;4174.3321068628875;30255.999283221838;30441.391172176653;31651.683483165103;32342.029739107864;32383.838080809444;3338.532605435241;3353.111425472252;3357.1942733743726;3364.8591320839323;3508.19311558343;449921;454089;454210;454339;455203;64652.030219546745;64966.67516662386;64971.700565988416;64995;65145;66997.66004679879;67087.32912670908;67185.99221011689;67268.32731672718;67383.66308168428;17613.55966100832;17806.287748489915;17855;17870.642587148184;17896.194671239824;13123.671908202372;13151.079424440388;13155.736885262433;13168.868311316955;13176.47294108244;15484.92257538705;15749.685006300038;15755.921220393824;16208.675826483404;17152.656946861243;5582.302212223472;7831.608419578998;7885.526868387915;7906.802329941683;7953.403494737918;803.8826031815664;866.6273502393905;889.7898857553722;902.1925376787739;920.9639155949557;31331.530027049157;31541.842290788398;31583.684163158076;31643.525347119812;32108.197295067344;996.7059717383389;1084.5444913136503;1094.3597995172754;1117.709395557161;1242.3912282981455;15513.224338783015;15757;16328.673426531403;16471.25879335433;16848.326066957183;621942;628433;628474;628777;629518;55429.722851385486;56596.71701641548;56627.43372566222;63624.68187659032;64076;1367.7538043152128;1392.060359257497;1455.992720036393;1478.4751413248573;1504.1501551623298;28449.28876778097;30939.381212376076;31530.211744706565;33292.50061249132;34059.65940340565;54086;54149.729251355064;54671.453285468226;54692.72653636865;54870.72564637151;543001;544657.2767136297;544794;545960;627551;23392;27877.581836272067;28698.282542936595;29323.41353172882;29401.705982939897;50296.74851625718;50393.74803125961;50480.24279635735;51496.22755658743;52207.47792522178;40138;40720.592794072865;41331.7933410343;42444;42892.35661465018;40546;40725;40983.38524922188;42360;42565.57434425616;40314;40819.795901020305;40991.385129222486;41133.58866411417;41255;29091;32339.35321293608;35093.29813403667;35829.1042723934;36338.09154771152;24914.626280606168;25866.35334116662;25870.48259034771;25891.61162582525;26405 14:25:15 INFO - PROCESS | 6977 | |2;jquery.html;306.1138005474152;401.29372304743663;404.5954045954046;420.222588211808;428.3617410059011;20139.496512587193;21317.36047918565;21843.781562184373;22212.000459979277;22215;22017.66973495399;22312.553748925013;22376;22478;22527.662085068736;5558.99999999999;5976.611520251192;6029.577929544934;6042.758289668408;6049.1228771828055;4274.401583778274;4458.576435238647;5844.736986835603;5924.674142922137;5965.910511342312;4535.818567257305;6598.472122230234;6690.899636505456;6692.163479565054;6705.631190284533;6456.515761317873;6590.80227593173;6680.799576012728;6681.064650948871;6685.665716714169;5862.589618726691;5866.2373891393845;5868.09044598088;5871.089981052944;5883.441073098049;27868.60656967164;28169.732362043756;28177.57733633997;28182.295442613893;28520.572191417144;2769.127724766692;2772.514809908278;2796.902108426216;2808.49447099522;2809.887604495818;15727.842721572752;15759.763603545956;15859.52421427359;15882.76175857363;15986.920065399598;1852.9993803346176;1856.6101118765075;1860.6557786809349;1893.214316058834;1903.0674969265099;123713;126091.36954315261;128913.06630400551;130399.99999999905;130692.34653826765;9478;11571.768564628828;11774.764504709858;11818.586349477728;12425.627231182898;15478.458253961282;15538.922305388402;15548.455804046804;15554.533363999099;15558.533244002698;9054.230390416888;9229.446233226028;9272.536373181314;9285.164335209729;9347.392419492711;8996.460212387277;9065.002849686529;9106.134917182857;9241.953790231006;9276.443413395218;7496.512726672749;7642.172396213326;7658.65536050879;7663.770086897402;7675.923240767633;1654.594624317026;2023.5447024419682;2030.066169562018;2034.6337659221185;2038.8368930485526;400.7255030304251;402.30803018807603;988.7972965542046;1031.437866362834;1109.3565731875492;11590.94204528972;12100.939495302644;12178.695532611579;12256.44845981933;12446.31545265001;434.90866917946954;437.4946936288592;439.1743522178284;451.8192722910862;454.8771831605448;5520;5777.046787280052;6199.690015499297;6247.437730604177;6394.296627370985;771251;772779;813608;815060;843747;149583.2520837389;151626;155590.44409555758;155753;157222;1107.5514416661265;1127.0870594818223;1178.723000094977;1179.3277831636058;1185.5435657272185;18943.715844262624;19158.71261931044;19796.90101549483;20057.899710501355;20289.391318260477;63218;63280.36719632929;64125.71748565096;64533.67733161304;64628.67685661541;70981;94011.82934938645;94307.58538622063;96677.06645867183;96731;8403.873941890753;8759.868601971102;8848.734537963872;8859.158379953895;8923.598438070432;9859.901400985898;11262;13147.342632868127;13355.732885342433;13925.651858703613;10901.781964360827;11280.32318060919;11411.657650270505;11499.482523286304;11629;11297.604583839526;11337.09303255721;11424.885751142383;11622.07023438106;11653.6503904883;6199.597026193283;8675.869861952202;11412.771744565229;11436.828447573127;11764.941175294069;8418.242358187792;8570.74287771368;8757.649694012169;8822.911770882209;8882.467051976902;9755;10770.51532681047;11603;11769.058475321783;11787.882121179022 14:25:15 INFO - PROCESS | 6977 | |3;mootools.html;1287.349888306405;1372.5127579709197;1385.2450414524083;1443.6318738721627;1488.4343949299264;7639.618019099051;8098.352131829454;8354.665813367457;8355.039170495387;8460.830783384328;8224.05423376312;8308.50148991061;8338.624761885714;8343.791405214874;8351.20663536963;2109.997751068238;2389.581823180945;2443.9857459154427;2450.13020377766;2454.3864033991504;2211.402921211272;2222.677711731798;2229.57638048771;2232.330300909721;2366.928992130239;2407.590709579367;2419.697537807774;2420.624803155505;2421.2131057406327;2431.112643884987;2340.9648855267183;2379.381360846175;2382.5115851250453;2386.5226954608975;2389.593769059264;2346.483773569812;2351.376885125443;2406.470576473173;2409.903603855844;2414.7223069346896;8531;8595.054544000155;8595.968483781924;8601.95699021507;8629.784255393603;5142.125838607446;5272.92090618641;5284.524392804666;5287.86780330491;5302.337207849019;3523.273595937972;3550.627184145679;3556.87550935716;3566.5006899034156;3601.891943241707;1263.759885621729;1274.840644919385;1289.6711338608595;1313.6321829887647;1329.242331870834;11074;11109.388983605899;11112.333260004345;11122.721931951684;11145.777084458347;4670.673052886334;4786.569208771228;4859.878503037382;4871.050145221648;4905.877353066202;9776.413415195111;9780.755481113029;9788.314817962817;9797.216222702167;9848.950755246322;5404.8108316208745;5430.402655707869;5434.619576629677;5438.211459338374;5439.912017596496;4777.641676874248;4790.401199850019;4876.073546026244;4925.433575138905;4992.675476094042;3604.567451905788;3671.7796932184156;3673.008287762289;3864;3922.490076290121;1057.7567159553191;1156.2888823373733;1157.0859021373021;1160.1125139268465;1199.280431740966;721.6932803558572;798.5833825214374;952.7522844060594;959.8896126945351;999.0958182844392;5655.830325090254;5709.400512946164;5848.035074212792;5893.850699113717;5959.0763431668165;916.8853893263342;954.4464210757744;1011.3426272922659;1076.0530732954949;1079.1528650009705;3067.7699172562147;3761.6614504694708;3797.6771974382486;4084.101497670508;4109;10002.099811017044;10352.430616316175;10357.63748268807;10364.326318789255;10383.428911409945;9247.583858726239;9613.759656008655;10154.339967902062;10377.429241391796;10412.68761937143;6987.161540615159;7799.80500487481;8127.024757029194;8179.959100204461;8196.590170491452;5665.235193248858;5686.2607860977805;5732.828015159552;5848.883022339444;5920.615160014585;9270.351075424656;9285.257179425495;9365.953170234377;9388.76528086776;9424.198943089914;7296.854062918818;8988.415752976036;9354;9598;9603.90396096058;6817.181938167451;6903.75836845708;6925.861482770216;6980.127484064492;7024.648767561499;8000.759977200693;8083.919160808552;8101.946746923098;8104.5137291762685;8130.146334635015;7115.85768284621;7301.817454563678;7309.159446663702;7406.222346653739;7412.888806667796;7031.824204394931;7127.643617819192;7192.208857025618;7242.6740796663225;7290.088738907637;6489.059086432535;6590.275069742229;6648.368405001517;6653.268140504444;6654.401103900672;5044.621653376085;5059.558025962583;5089.185730283137;5095.878641964801;5343.278657381359;3796.430535419709;5115.386153661584;5117.744112794271;5256.894862102813;5352.197170424468 14:25:15 INFO - PROCESS | 6977 | |4;prototype.html;306.3551224672065;357.6763029458341;368.15875723970714;374.90252534341096;380.4635463995765;4368.213721530124;4707.411573553301;5023.221400682891;5141.434442211354;5319;4202.474690663667;4940.505949405057;5019.899602007967;5036.445990940993;5189.546926860476;3290.720288775445;3308.8676452941854;3719.7396182267253;4124.814383352741;4126.607972242639;3228;3508.561429821272;4035.639151096612;4079.3676980068135;4115.279826030448;3613.855445782179;3682.650148235913;4049.6760259179196;4070.168424209118;4080.9795951020205;4066.8779936601654;4091.509018917749;4117.279476091687;4125.030617804813;4131.173765246963;3565.5008298838184;3597.8740744074094;3609.693176080036;3637.963620363789;3645.106948797535;4932.446279421971;5090.49095090488;5097.872553186163;5121.308623335839;5163.108659150887;3976.7613943163215;4290.039872487973;4745.715257084586;4757.833475828329;4787.784549695272;4403.075354175627;4769.856904292877;5538.944610553924;5559.416261292547;5579.066757935646;3375.8143302118374;4025.9798701006603;4038.9296836338394;4040.4747382840337;4104.56902025286;5103.362079740033;5205.7397130143345;5597.45315881273;5826.1552074948895;5908.143319218732;3749.850005999784;4082.408050832613;4097.918041639151;4101.179764047202;4110.17796440713;4134.793260336971;4176.206520761046;4189.769562674082;4228.788560571959;4237.749863790128;3793.7534060285993;4670.705395010312;4737.336772851803;4752.453467851172;4777.829431789234;4492.573205545468;5640.351359593617;5651.400355836361;5665.603407761417;5665.631733937281;1125.876153623101;1327.561904571489;1328.8006798980036;1354.3634491788844;1373.642852858264;813.7802793245909;892.1569117184199;923.8106188231396;924.5977999570208;928.178561972659;4506.918339598473;4549.681522293474;4653.769841269841;5057.317262169634;5239.685618862881;4976.129177393942;5616.494515493625;5639.731060511353;5664.291963504562;5726.885462290814;4632.305154226893;5094.490550944876;5174.327337446108;5204.375474943031;5217.50433708797;2405.592728253991;2508.786753126005;2683.9329016774345;2771.974369483304;2788.707185745508;5413.675179489164;5502.669839809624;5548.5838562108;5550.888982220333;5551.666899986014;4685.976570117127;5016.423111342169;5261.736913154327;5495.505404513613;5541.778328866801;5022.497750225021;5228.398734145546;5364.597655175956;5605.439456054443;5634.464725851038;4822.614190864792;5102.948970510396;5224.712640804641;5385.434529374359;5448.891022179613;4986.675866068694;5170.844874653766;5177.689338639693;5359.946400535945;5385.946140538545;4989.077020751172;5574.9163762542785;5663.433656634304;5680.460356266148;5726.856828579319;3323.30210655765;3397.745169112277;3688.6536414208085;3705.4071348585176;3858.401947698111;4881.413540599248;4920.704757714549;5188.22176673502;5471.972640136773;5542.528885044655;4339.609435150852;4406.074724307931;4921.163402221559;5137.460566640449;5365.59758018158;4216.451861258017;4372.387865698868;4555.40779698637;4587.38070360497;4920.384951881015;4267.997020700195;4391.604755572014;4695.12652062057;4920.458749537476;5080.796768129381;5129;5144.742762861917;5370.865728356823;5376.784928602969;5581.665100093845;4791.137595232892;4843.951560484491;5082.364704411949;5474.671519708831;5485.314335708036 14:25:15 INFO - PROCESS | 6977 | |5;yui.html;646.8124243969249;766.1304419483885;791.9128895821459;871.3856731004643;888.3026823943206;15137.772933405993;15693.607659808496;15700.21498925055;15700.528984130466;15710.607234819106;14339;14367.568972930829;14470.5658830235;14472.204028778413;14486.130832150078;698.106423777563;709.0498731699522;725.1226016520017;878.3193025405315;884.1379654836547;714.7033980897921;895.9328050396214;907.6596276396351;908.2552307108174;909.9808214799434;963.7831487915198;965.4400447740329;966.5553845231202;968.0368033806373;970.0638883477443;959.1032384720239;960.4381436859445;960.4957397366369;961.9947155222809;962.6341990043809;720.2221600671314;720.718919621348;722.1009842745763;722.4653756220412;722.7145277615313;15488.5353439397;15736.606584835356;15859.762103568455;15940.840591594051;16340.264688089064;15147.469838555708;15480;15482.845171548253;15542.922285388613;15656.686866262611;11809.527618895234;11873.643790686207;11913.702157446047;12019.51921923122;12146.817797733042;3803.315403227418;3814.713896457749;3822.4648549203134;3962.663173630216;3967.8016099195215;95983;102557;102804.97195028029;108085.45957270241;112809.99999999919;11101.222914396076;11539.365334906493;11724.413779311;11780.410979450993;11794.646160615195;24033.399165020666;24235.636465453033;24236.1517346892;24316.513669726508;24695.753042469347;7802.570858602831;7924.167962363868;7954.125046244909;8268;8310.875336869953;4381.846635367747;4392.802323895432;4417.447819022622;4505.43682039745;4618.261078227468;3597.640235976434;3674.9081272967856;3691.390920498088;3705.2033812729856;3711.406175012039;662.7050962321721;667.3326673326674;669.1201070592156;680.9863802724017;683.3883674111643;599.5503372470647;662.8607992321666;666.5249229886842;669.3540733192395;669.8392385827366;8450.61972211252;9419.293552983554;9533;10026;10197;645.5094128462403;658.90116482528;690.3648643248123;698.3679769808332;713.1228588835761;4837.37114175155;4864.586510146677;4887.36464259644;4909.435414927258;4926.968381897086;104560.47719761352;106769.4661526703;109379;109703.35444968332;109965.45017274862;72996;85619.57190214009;94974.0502594979;96566.51716741371;96730.0326996721;61410.69294653588;67086;80334;84730.57634711787;87222;9593.328467007243;9620.278479113955;9670.274729395183;9679.951600241953;9733;47291;49503.25745113898;52294;53455;55546;72581.27418725746;73542;73697;74821;75505.24494754981;11535.942320288344;11771.117166212398;11968.401579921143;12012.819807703067;12135.575254866037;12159.270443773403;12236.388180591113;12442.315672638091;12709.428075736429;13134.211947283193;10491.213159012952;10915.454227288763;11019.231441833328;11092.722681933015;11501.48243329069;11727.648170554898;11824.172307938707;11837.112216583619;11880.643580692593;12434.875651243734;11201;11873.643790686294;11902;12033.157678962738;12166.391680415767;9580.66467673628;9901.207903367569;9956.303058785816;10136.442495662513;10172.28793984414;9783.559739811868;9852.050609305577;9895.703128906145;9946.950265248917;11592.304461732323 14:25:15 INFO - PROCESS | 6977 | __end_tp_report 14:25:15 INFO - PROCESS | 6977 | __start_cc_report 14:25:15 INFO - PROCESS | 6977 | _x_x_mozilla_cycle_collect,1309 14:25:15 INFO - PROCESS | 6977 | __end_cc_report 14:25:15 INFO - PROCESS | 6977 | __startTimestamp1490304315193__endTimestamp 14:25:15 INFO - PROCESS | 6977 | 14:25:15 INFO - PROCESS | 6977 | ------- Summary: start ------- 14:25:15 INFO - PROCESS | 6977 | Number of tests: 6 14:25:15 INFO - PROCESS | 6977 | 14:25:15 INFO - PROCESS | 6977 | [#0] dojo.html Cycles:165 Average:5847.83 Median:6150.05 stddev:637.96 (10.4%) stddev-sans-first:610.19 14:25:15 INFO - PROCESS | 6977 | Values: 3394.6 3404.1 3422.9 3423.0 3492.4 4814.6 5777.4 5817.3 5824.9 5833.8 5811.3 5906.7 5908.9 5911.7 5933.8 5214.3 5278.1 5289.7 5298.2 5339.5 5221.9 5232.0 5233.1 5369.3 5385.6 5318.7 5320.0 5337.3 5342.5 5391.2 5350.9 5378.9 5381.5 5384.8 5385.7 5161.7 5230.9 5304.6 5314.9 5353.4 5673.3 5750.1 5796.5 5806.0 5822.0 6194.7 6204.4 6215.0 6226.3 6253.2 6224.6 6294.4 6301.6 6310.4 6317.9 5863.5 5917.9 5996.2 6008.9 6076.0 6345.4 6399.9 6410.3 6411.7 6425.2 6252.3 6263.1 6264.3 6275.2 6279.9 6173.4 6185.5 6209.2 6271.5 6276.7 6182.3 6190.9 6214.1 6227.9 6252.5 6173.6 6192.4 6201.2 6202.7 6222.5 4963.8 5101.4 5111.8 5118.3 5136.7 4526.4 4531.0 4579.7 4588.2 4594.6 6054.4 6076.9 6078.8 6082.1 6113.4 6266.1 6287.9 6329.9 6331.9 6342.2 5819.6 5822.5 5851.4 6001.7 6060.8 5516.2 5524.9 5527.4 5529.1 5535.4 6331.8 6337.4 6337.9 6346.4 6383.6 6202.1 6205.3 6307.6 6312.2 6321.7 6373.0 6494.6 6523.7 6529.1 6537.6 6174.8 6226.2 6232.3 6237.7 6253.0 6171.5 6206.5 6224.5 6293.4 6323.3 6087.2 6251.0 6254.9 6269.8 6305.5 6143.2 6269.1 6291.3 6294.9 6342.1 5092.5 6040.8 6137.5 6149.9 6207.7 6244.2 6253.4 6256.8 6273.2 6291.9 6146.0 6150.0 6190.1 6197.3 6207.2 14:25:15 INFO - PROCESS | 6977 | 14:25:15 INFO - PROCESS | 6977 | [#1] ext.html Cycles:180 Average:69575.15 Median:22457.01 stddev:147274.29 (655.8%) stddev-sans-first:147596.06 14:25:15 INFO - PROCESS | 6977 | Values: 480.9 504.0 518.9 534.0 534.2 32883.2 33904.8 33952.5 34067.0 42516.0 45014.1 45428.0 45466.3 45542.8 45687.6 9548.5 9673.8 9688.2 9688.2 9777.9 9065.8 9266.3 9537.5 9689.7 11628.5 11474.5 11653.0 11745.2 11750.9 11821.0 11722.6 11806.8 11875.9 11882.0 11907.9 11742.4 11786.7 11786.9 11788.4 11802.2 41819.7 42028.0 42054.0 42111.2 42166.2 4064.0 4094.2 4119.6 4133.6 4174.3 30256.0 30441.4 31651.7 32342.0 32383.8 3338.5 3353.1 3357.2 3364.9 3508.2 449921.0 454089.0 454210.0 454339.0 455203.0 64652.0 64966.7 64971.7 64995.0 65145.0 66997.7 67087.3 67186.0 67268.3 67383.7 17613.6 17806.3 17855.0 17870.6 17896.2 13123.7 13151.1 13155.7 13168.9 13176.5 15484.9 15749.7 15755.9 16208.7 17152.7 5582.3 7831.6 7885.5 7906.8 7953.4 803.9 866.6 889.8 902.2 921.0 31331.5 31541.8 31583.7 31643.5 32108.2 996.7 1084.5 1094.4 1117.7 1242.4 15513.2 15757.0 16328.7 16471.3 16848.3 621942.0 628433.0 628474.0 628777.0 629518.0 55429.7 56596.7 56627.4 63624.7 64076.0 1367.8 1392.1 1456.0 1478.5 1504.2 28449.3 30939.4 31530.2 33292.5 34059.7 54086.0 54149.7 54671.5 54692.7 54870.7 543001.0 544657.3 544794.0 545960.0 627551.0 23392.0 27877.6 28698.3 29323.4 29401.7 50296.7 50393.7 50480.2 51496.2 52207.5 40138.0 40720.6 41331.8 42444.0 42892.4 40546.0 40725.0 40983.4 42360.0 42565.6 40314.0 40819.8 40991.4 41133.6 41255.0 29091.0 32339.4 35093.3 35829.1 36338.1 24914.6 25866.4 25870.5 25891.6 26405.0 14:25:15 INFO - PROCESS | 6977 | 14:25:15 INFO - PROCESS | 6977 | [#2] jquery.html Cycles:180 Average:42536.88 Median:28351.43 stddev:133449.34 (470.7%) stddev-sans-first:133786.03 14:25:15 INFO - PROCESS | 6977 | Values: 306.1 401.3 404.6 420.2 428.4 20139.5 21317.4 21843.8 22212.0 22215.0 22017.7 22312.6 22376.0 22478.0 22527.7 5559.0 5976.6 6029.6 6042.8 6049.1 4274.4 4458.6 5844.7 5924.7 5965.9 4535.8 6598.5 6690.9 6692.2 6705.6 6456.5 6590.8 6680.8 6681.1 6685.7 5862.6 5866.2 5868.1 5871.1 5883.4 27868.6 28169.7 28177.6 28182.3 28520.6 2769.1 2772.5 2796.9 2808.5 2809.9 15727.8 15759.8 15859.5 15882.8 15986.9 1853.0 1856.6 1860.7 1893.2 1903.1 123713.0 126091.4 128913.1 130400.0 130692.3 9478.0 11571.8 11774.8 11818.6 12425.6 15478.5 15538.9 15548.5 15554.5 15558.5 9054.2 9229.4 9272.5 9285.2 9347.4 8996.5 9065.0 9106.1 9242.0 9276.4 7496.5 7642.2 7658.7 7663.8 7675.9 1654.6 2023.5 2030.1 2034.6 2038.8 400.7 402.3 988.8 1031.4 1109.4 11590.9 12100.9 12178.7 12256.4 12446.3 434.9 437.5 439.2 451.8 454.9 5520.0 5777.0 6199.7 6247.4 6394.3 771251.0 772779.0 813608.0 815060.0 843747.0 149583.3 151626.0 155590.4 155753.0 157222.0 1107.6 1127.1 1178.7 1179.3 1185.5 18943.7 19158.7 19796.9 20057.9 20289.4 63218.0 63280.4 64125.7 64533.7 64628.7 70981.0 94011.8 94307.6 96677.1 96731.0 8403.9 8759.9 8848.7 8859.2 8923.6 9859.9 11262.0 13147.3 13355.7 13925.7 10901.8 11280.3 11411.7 11499.5 11629.0 11297.6 11337.1 11424.9 11622.1 11653.7 6199.6 8675.9 11412.8 11436.8 11764.9 8418.2 8570.7 8757.6 8822.9 8882.5 9755.0 10770.5 11603.0 11769.1 11787.9 14:25:15 INFO - PROCESS | 6977 | 14:25:15 INFO - PROCESS | 6977 | [#3] mootools.html Cycles:180 Average:5532.02 Median:5278.72 stddev:3005.80 (56.9%) stddev-sans-first:2997.30 14:25:15 INFO - PROCESS | 6977 | Values: 1287.3 1372.5 1385.2 1443.6 1488.4 7639.6 8098.4 8354.7 8355.0 8460.8 8224.1 8308.5 8338.6 8343.8 8351.2 2110.0 2389.6 2444.0 2450.1 2454.4 2211.4 2222.7 2229.6 2232.3 2366.9 2407.6 2419.7 2420.6 2421.2 2431.1 2341.0 2379.4 2382.5 2386.5 2389.6 2346.5 2351.4 2406.5 2409.9 2414.7 8531.0 8595.1 8596.0 8602.0 8629.8 5142.1 5272.9 5284.5 5287.9 5302.3 3523.3 3550.6 3556.9 3566.5 3601.9 1263.8 1274.8 1289.7 1313.6 1329.2 11074.0 11109.4 11112.3 11122.7 11145.8 4670.7 4786.6 4859.9 4871.1 4905.9 9776.4 9780.8 9788.3 9797.2 9849.0 5404.8 5430.4 5434.6 5438.2 5439.9 4777.6 4790.4 4876.1 4925.4 4992.7 3604.6 3671.8 3673.0 3864.0 3922.5 1057.8 1156.3 1157.1 1160.1 1199.3 721.7 798.6 952.8 959.9 999.1 5655.8 5709.4 5848.0 5893.9 5959.1 916.9 954.4 1011.3 1076.1 1079.2 3067.8 3761.7 3797.7 4084.1 4109.0 10002.1 10352.4 10357.6 10364.3 10383.4 9247.6 9613.8 10154.3 10377.4 10412.7 6987.2 7799.8 8127.0 8180.0 8196.6 5665.2 5686.3 5732.8 5848.9 5920.6 9270.4 9285.3 9366.0 9388.8 9424.2 7296.9 8988.4 9354.0 9598.0 9603.9 6817.2 6903.8 6925.9 6980.1 7024.6 8000.8 8083.9 8101.9 8104.5 8130.1 7115.9 7301.8 7309.2 7406.2 7412.9 7031.8 7127.6 7192.2 7242.7 7290.1 6489.1 6590.3 6648.4 6653.3 6654.4 5044.6 5059.6 5089.2 5095.9 5343.3 3796.4 5115.4 5117.7 5256.9 5352.2 14:25:15 INFO - PROCESS | 6977 | 14:25:15 INFO - PROCESS | 6977 | [#4] prototype.html Cycles:180 Average:4366.79 Median:4806.88 stddev:1296.51 (27.0%) stddev-sans-first:1263.82 14:25:15 INFO - PROCESS | 6977 | Values: 306.4 357.7 368.2 374.9 380.5 4368.2 4707.4 5023.2 5141.4 5319.0 4202.5 4940.5 5019.9 5036.4 5189.5 3290.7 3308.9 3719.7 4124.8 4126.6 3228.0 3508.6 4035.6 4079.4 4115.3 3613.9 3682.7 4049.7 4070.2 4081.0 4066.9 4091.5 4117.3 4125.0 4131.2 3565.5 3597.9 3609.7 3638.0 3645.1 4932.4 5090.5 5097.9 5121.3 5163.1 3976.8 4290.0 4745.7 4757.8 4787.8 4403.1 4769.9 5538.9 5559.4 5579.1 3375.8 4026.0 4038.9 4040.5 4104.6 5103.4 5205.7 5597.5 5826.2 5908.1 3749.9 4082.4 4097.9 4101.2 4110.2 4134.8 4176.2 4189.8 4228.8 4237.7 3793.8 4670.7 4737.3 4752.5 4777.8 4492.6 5640.4 5651.4 5665.6 5665.6 1125.9 1327.6 1328.8 1354.4 1373.6 813.8 892.2 923.8 924.6 928.2 4506.9 4549.7 4653.8 5057.3 5239.7 4976.1 5616.5 5639.7 5664.3 5726.9 4632.3 5094.5 5174.3 5204.4 5217.5 2405.6 2508.8 2683.9 2772.0 2788.7 5413.7 5502.7 5548.6 5550.9 5551.7 4686.0 5016.4 5261.7 5495.5 5541.8 5022.5 5228.4 5364.6 5605.4 5634.5 4822.6 5102.9 5224.7 5385.4 5448.9 4986.7 5170.8 5177.7 5359.9 5385.9 4989.1 5574.9 5663.4 5680.5 5726.9 3323.3 3397.7 3688.7 3705.4 3858.4 4881.4 4920.7 5188.2 5472.0 5542.5 4339.6 4406.1 4921.2 5137.5 5365.6 4216.5 4372.4 4555.4 4587.4 4920.4 4268.0 4391.6 4695.1 4920.5 5080.8 5129.0 5144.7 5370.9 5376.8 5581.7 4791.1 4844.0 5082.4 5474.7 5485.3 14:25:15 INFO - PROCESS | 6977 | 14:25:15 INFO - PROCESS | 6977 | [#5] yui.html Cycles:180 Average:20652.66 Median:4850.98 stddev:30104.19 (620.6%) stddev-sans-first:30151.16 14:25:15 INFO - PROCESS | 6977 | Values: 646.8 766.1 791.9 871.4 888.3 15137.8 15693.6 15700.2 15700.5 15710.6 14339.0 14367.6 14470.6 14472.2 14486.1 698.1 709.0 725.1 878.3 884.1 714.7 895.9 907.7 908.3 910.0 963.8 965.4 966.6 968.0 970.1 959.1 960.4 960.5 962.0 962.6 720.2 720.7 722.1 722.5 722.7 15488.5 15736.6 15859.8 15940.8 16340.3 15147.5 15480.0 15482.8 15542.9 15656.7 11809.5 11873.6 11913.7 12019.5 12146.8 3803.3 3814.7 3822.5 3962.7 3967.8 95983.0 102557.0 102805.0 108085.5 112810.0 11101.2 11539.4 11724.4 11780.4 11794.6 24033.4 24235.6 24236.2 24316.5 24695.8 7802.6 7924.2 7954.1 8268.0 8310.9 4381.8 4392.8 4417.4 4505.4 4618.3 3597.6 3674.9 3691.4 3705.2 3711.4 662.7 667.3 669.1 681.0 683.4 599.6 662.9 666.5 669.4 669.8 8450.6 9419.3 9533.0 10026.0 10197.0 645.5 658.9 690.4 698.4 713.1 4837.4 4864.6 4887.4 4909.4 4927.0 104560.5 106769.5 109379.0 109703.4 109965.5 72996.0 85619.6 94974.1 96566.5 96730.0 61410.7 67086.0 80334.0 84730.6 87222.0 9593.3 9620.3 9670.3 9680.0 9733.0 47291.0 49503.3 52294.0 53455.0 55546.0 72581.3 73542.0 73697.0 74821.0 75505.2 11535.9 11771.1 11968.4 12012.8 12135.6 12159.3 12236.4 12442.3 12709.4 13134.2 10491.2 10915.5 11019.2 11092.7 11501.5 11727.6 11824.2 11837.1 11880.6 12434.9 11201.0 11873.6 11902.0 12033.2 12166.4 9580.7 9901.2 9956.3 10136.4 10172.3 9783.6 9852.1 9895.7 9947.0 11592.3 14:25:15 INFO - PROCESS | 6977 | -------- Summary: end -------- 14:25:15 INFO - PROCESS | 6977 | 14:25:15 INFO - TEST-INFO | 6977: exit 0 14:25:15 INFO - TEST-OK | dromaeo_css | took 1117308ms 14:25:15 INFO - TEST-START | kraken 14:25:15 INFO - operating with platform_type : mac_ 14:25:15 INFO - Initialising browser for kraken test... 14:25:15 INFO - TEST-INFO | started process 6979 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpX6H1O7/profile http://localhost:57840/getInfo.html) 14:25:18 INFO - PROCESS | 6979 | __metrics Screen width/height:1600/1200 14:25:18 INFO - PROCESS | 6979 | colorDepth:24 14:25:18 INFO - PROCESS | 6979 | Browser inner width/height: 1024/689 14:25:18 INFO - PROCESS | 6979 | __metrics 14:25:18 INFO - PROCESS | 6979 | 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:25:18 INFO - PROCESS | 6979 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:25:18 INFO - TEST-INFO | 6979: exit 0 14:25:18 INFO - Browser initialized. 14:25:18 INFO - Running cycle 1/1 for kraken test... 14:25:19 INFO - TEST-INFO | started process 6981 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpX6H1O7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:30 INFO - PROCESS | 6981 | RSS: Main: 166957056 14:25:30 INFO - PROCESS | 6981 | 14:25:33 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57840/tests/kraken/driver.html?testName=audio-beat-detection) 14:25:34 INFO - PROCESS | 6981 | RSS: Main: 215531520 14:25:34 INFO - PROCESS | 6981 | 14:25:37 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57840/tests/kraken/driver.html?testName=audio-dft) 14:25:37 INFO - PROCESS | 6981 | RSS: Main: 229527552 14:25:37 INFO - PROCESS | 6981 | 14:25:40 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57840/tests/kraken/driver.html?testName=audio-fft) 14:25:41 INFO - PROCESS | 6981 | RSS: Main: 326328320 14:25:41 INFO - PROCESS | 6981 | 14:25:43 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57840/tests/kraken/driver.html?testName=audio-oscillator) 14:25:44 INFO - PROCESS | 6981 | RSS: Main: 228687872 14:25:44 INFO - PROCESS | 6981 | 14:25:46 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57840/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:25:46 INFO - PROCESS | 6981 | RSS: Main: 228904960 14:25:46 INFO - PROCESS | 6981 | 14:25:49 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57840/tests/kraken/driver.html?testName=imaging-darkroom) 14:25:50 INFO - PROCESS | 6981 | RSS: Main: 270245888 14:25:50 INFO - PROCESS | 6981 | 14:25:53 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57840/tests/kraken/driver.html?testName=imaging-desaturate) 14:25:53 INFO - PROCESS | 6981 | RSS: Main: 272269312 14:25:53 INFO - PROCESS | 6981 | 14:25:56 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57840/tests/kraken/driver.html?testName=json-parse-financial) 14:25:57 INFO - PROCESS | 6981 | RSS: Main: 267505664 14:25:57 INFO - PROCESS | 6981 | 14:25:58 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57840/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:25:59 INFO - PROCESS | 6981 | RSS: Main: 246493184 14:25:59 INFO - PROCESS | 6981 | 14:26:01 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57840/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:26:01 INFO - PROCESS | 6981 | RSS: Main: 249139200 14:26:01 INFO - PROCESS | 6981 | 14:26:03 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57840/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:26:04 INFO - PROCESS | 6981 | RSS: Main: 259461120 14:26:04 INFO - PROCESS | 6981 | 14:26:07 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57840/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:26:08 INFO - PROCESS | 6981 | RSS: Main: 272523264 14:26:08 INFO - PROCESS | 6981 | 14:26:10 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57840/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:26:11 INFO - PROCESS | 6981 | RSS: Main: 266784768 14:26:11 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | Cycle 1(1): loaded http://localhost:57840/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57840/tests/kraken/driver.html?testName=ai-astar) 14:26:13 INFO - PROCESS | 6981 | RSS: Main: 310788096 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | __start_tp_report 14:26:13 INFO - PROCESS | 6981 | _x_x_mozilla_page_load 14:26:13 INFO - PROCESS | 6981 | _x_x_mozilla_page_load_details 14:26:13 INFO - PROCESS | 6981 | |i|pagename|runs| 14:26:13 INFO - PROCESS | 6981 | |0;ai-astar;113;116;115;116;113;116;115;116;116;116 14:26:13 INFO - PROCESS | 6981 | |1;audio-beat-detection;146;109;108;144;109;108;108;107;129;139 14:26:13 INFO - PROCESS | 6981 | |2;audio-dft;183;188;184;186;185;185;183;184;184;186 14:26:13 INFO - PROCESS | 6981 | |3;audio-fft;82;58;57;89;61;59;58;58;71;57 14:26:13 INFO - PROCESS | 6981 | |4;audio-oscillator;84;70;86;68;68;71;81;67;68;80 14:26:13 INFO - PROCESS | 6981 | |5;imaging-gaussian-blur;88;85;89;86;89;84;89;86;89;130 14:26:13 INFO - PROCESS | 6981 | |6;imaging-darkroom;95;95;95;95;94;94;95;94;108;151 14:26:13 INFO - PROCESS | 6981 | |7;imaging-desaturate;86;87;86;91;88;86;87;92;124;84 14:26:13 INFO - PROCESS | 6981 | |8;json-parse-financial;53;52;52;54;55;55;57;56;56;56 14:26:13 INFO - PROCESS | 6981 | |9;json-stringify-tinderbox;65;73;70;75;73;70;70;71;71;72 14:26:13 INFO - PROCESS | 6981 | |10;stanford-crypto-aes;82;81;83;83;83;79;80;85;89;101 14:26:13 INFO - PROCESS | 6981 | |11;stanford-crypto-ccm;133;131;133;130;131;132;130;134;187;140 14:26:13 INFO - PROCESS | 6981 | |12;stanford-crypto-pbkdf2;165;164;164;163;164;162;161;166;164;162 14:26:13 INFO - PROCESS | 6981 | |13;stanford-crypto-sha256-iterative;64;65;65;63;66;66;82;84;80;84 14:26:13 INFO - PROCESS | 6981 | __end_tp_report 14:26:13 INFO - PROCESS | 6981 | __start_cc_report 14:26:13 INFO - PROCESS | 6981 | _x_x_mozilla_cycle_collect,2082 14:26:13 INFO - PROCESS | 6981 | __end_cc_report 14:26:13 INFO - PROCESS | 6981 | __startTimestamp1490304373634__endTimestamp 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | ------- Summary: start ------- 14:26:13 INFO - PROCESS | 6981 | Number of tests: 14 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:1.23 (1.1%) stddev-sans-first:1.01 14:26:13 INFO - PROCESS | 6981 | Values: 113.0 116.0 115.0 116.0 113.0 116.0 115.0 116.0 116.0 116.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#1] audio-beat-detection Cycles:10 Average:120.70 Median:119.00 stddev:16.77 (14.1%) stddev-sans-first:15.09 14:26:13 INFO - PROCESS | 6981 | Values: 146.0 109.0 108.0 144.0 109.0 108.0 108.0 107.0 129.0 139.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:1.55 (0.8%) stddev-sans-first:1.50 14:26:13 INFO - PROCESS | 6981 | Values: 183.0 188.0 184.0 186.0 185.0 185.0 183.0 184.0 184.0 186.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#3] audio-fft Cycles:10 Average:65.00 Median:60.00 stddev:11.68 (19.5%) stddev-sans-first:10.65 14:26:13 INFO - PROCESS | 6981 | Values: 82.0 58.0 57.0 89.0 61.0 59.0 58.0 58.0 71.0 57.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#4] audio-oscillator Cycles:10 Average:74.30 Median:75.50 stddev:7.53 (10.0%) stddev-sans-first:7.12 14:26:13 INFO - PROCESS | 6981 | Values: 84.0 70.0 86.0 68.0 68.0 71.0 81.0 67.0 68.0 80.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:88.50 stddev:13.66 (15.4%) stddev-sans-first:14.43 14:26:13 INFO - PROCESS | 6981 | Values: 88.0 85.0 89.0 86.0 89.0 84.0 89.0 86.0 89.0 130.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#6] imaging-darkroom Cycles:10 Average:101.60 Median:95.00 stddev:17.86 (18.8%) stddev-sans-first:18.79 14:26:13 INFO - PROCESS | 6981 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 108.0 151.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#7] imaging-desaturate Cycles:10 Average:91.10 Median:87.00 stddev:11.81 (13.6%) stddev-sans-first:12.38 14:26:13 INFO - PROCESS | 6981 | Values: 86.0 87.0 86.0 91.0 88.0 86.0 87.0 92.0 124.0 84.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.50 stddev:1.78 (3.2%) stddev-sans-first:1.79 14:26:13 INFO - PROCESS | 6981 | Values: 53.0 52.0 52.0 54.0 55.0 55.0 57.0 56.0 56.0 56.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.50 stddev:2.67 (3.7%) stddev-sans-first:1.73 14:26:13 INFO - PROCESS | 6981 | Values: 65.0 73.0 70.0 75.0 73.0 70.0 70.0 71.0 71.0 72.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:83.00 stddev:6.40 (7.7%) stddev-sans-first:6.72 14:26:13 INFO - PROCESS | 6981 | Values: 82.0 81.0 83.0 83.0 83.0 79.0 80.0 85.0 89.0 101.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:133.00 stddev:17.43 (13.1%) stddev-sans-first:18.38 14:26:13 INFO - PROCESS | 6981 | Values: 133.0 131.0 133.0 130.0 131.0 132.0 130.0 134.0 187.0 140.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:164.00 stddev:1.51 (0.9%) stddev-sans-first:1.50 14:26:13 INFO - PROCESS | 6981 | Values: 165.0 164.0 164.0 163.0 164.0 162.0 161.0 166.0 164.0 162.0 14:26:13 INFO - PROCESS | 6981 | 14:26:13 INFO - PROCESS | 6981 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:73.00 stddev:9.23 (12.6%) stddev-sans-first:9.34 14:26:13 INFO - PROCESS | 6981 | Values: 64.0 65.0 65.0 63.0 66.0 66.0 82.0 84.0 80.0 84.0 14:26:13 INFO - PROCESS | 6981 | -------- Summary: end -------- 14:26:13 INFO - PROCESS | 6981 | 14:26:14 INFO - TEST-INFO | 6981: exit 0 14:26:14 INFO - TEST-OK | kraken | took 58705ms 14:26:14 INFO - SUITE-END | took 1176s 14:26:14 INFO - Completed test suite (00:19:36) 14:26:14 INFO - javascript benchmark 14:26:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3394.5587073680417, 3404.13194635368, 3422.863085476581, 3422.9828850855743, 3492.423750081237, 4814.638902082344, 5777.393373695759, 5817.272840894888, 5824.854378640536, 5833.82498525045, 5811.27359080115, 5906.734196961136, 5908.940910590893, 5911.733971971261, 5933.792317268896, 5214.270002199695, 5278.102722537178, 5289.709066001368, 5298.178782288752, 5339.466053394668, 5221.921671174935, 5232.0, 5233.0580495510985, 5369.301990741198, 5385.596080293974, 5318.680879147263, 5320.0, 5337.3061502004875, 5342.519173274404, 5391.245225668409, 5350.866228344303, 5378.865528361783, 5381.48875856793, 5384.838454846361, 5385.703786291752, 5161.7161056141895, 5230.895382092337, 5304.628675992643, 5314.867128321785, 5353.38436079848, 5673.262475878109, 5750.079987202028, 5796.50729687977, 5806.042003069489, 5821.970890145564, 6194.721237544276, 6204.441600255954, 6215.036669316263, 6226.252849658024, 6253.155823963798, 6224.564280500367, 6294.402031806971, 6301.6219026858535, 6310.368963103699, 6317.87364252717, 5863.501602363847, 5917.852053698606, 5996.190514280604, 6008.879822403527, 6076.0278355462915, 6345.428911397997, 6399.9360006400275, 6410.326915673881, 6411.743530258831, 6425.1968503937005, 6252.280987686383, 6263.091851681481, 6264.342244064399, 6275.152854364694, 6279.874402511924, 6173.41352571505, 6185.536084793658, 6209.192804935329, 6271.466925311308, 6276.717547710364, 6182.258129024546, 6190.876182476325, 6214.098955651405, 6227.906581401283, 6252.468540174136, 6173.59871608344, 6192.411720886508, 6201.162843016225, 6202.72087756043, 6222.502199824094, 4963.751812409365, 5101.387833460009, 5111.795528178905, 5118.334616499831, 5136.666116702402, 4526.411566496335, 4530.977345113253, 4579.725216486955, 4588.174128656874, 4594.563516465931, 6054.364291749391, 6076.878462430726, 6078.848028799315, 6082.148499210114, 6113.358097399798, 6266.122742816009, 6287.9056814147825, 6329.8734025320155, 6331.873362532723, 6342.207224096988, 5819.563532735062, 5822.505087067562, 5851.444112809277, 6001.729922153513, 6060.848478788065, 5516.227728118067, 5524.861878453071, 5527.364353099445, 5529.142982837586, 5535.391106978229, 6331.841703957346, 6337.366263373534, 6337.904931426125, 6346.365363463709, 6383.553151279366, 6202.131701561695, 6205.2553693557065, 6307.558470906993, 6312.242530896322, 6321.652309122858, 6372.968135159294, 6494.64279464634, 6523.67381630907, 6529.118568993125, 6537.5750576212395, 6174.845628859135, 6226.221722284715, 6232.314445410911, 6237.656928868956, 6252.968735156295, 6171.537134714825, 6206.534509911865, 6224.470919971853, 6293.402126797947, 6323.304436511888, 6087.178230938766, 6250.968745156245, 6254.937450625435, 6269.780557680459, 6305.464035557029, 6143.201383820075, 6269.059641053878, 6291.307956124731, 6294.937050629435, 6342.080398342307, 5092.465291144525, 6040.788572399945, 6137.478314343331, 6149.907751383822, 6207.720652570555, 6244.1570387997035, 6253.374662533893, 6256.812295631138, 6273.247210334789, 6291.937080629135, 6146.016637338004, 6150.04674275488, 6190.133381326708, 6197.349278325892, 6207.16203312547], "value": 5807.533637690479, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.8581468466802, 504.04735050754056, 518.9040027594895, 533.9626226164168, 534.2120372450634, 32883.177920552, 33904.830475847644, 33952.49071263933, 34066.977990660285, 42516.0, 45014.0997180057, 45428.0, 45466.31800522995, 45542.77228613853, 45687.62937111892, 9548.522573871296, 9673.758156046084, 9688.224942004623, 9688.224942004623, 9777.90222097777, 9065.818683626323, 9266.258699304039, 9537.523123843815, 9689.660861869836, 11628.476718547685, 11474.48364823585, 11652.951234388904, 11745.236559623598, 11750.941245293761, 11821.0, 11722.58970936013, 11806.7638647227, 11875.940620296844, 11882.049436045096, 11907.94046029773, 11742.412879355998, 11786.705332366759, 11786.941065294619, 11788.410579471078, 11802.232854864405, 41819.745407637514, 42028.0, 42054.0, 42111.1577768446, 42166.15667686629, 4063.9796801015805, 4094.222097801438, 4119.588041195856, 4133.565975572552, 4174.3321068628875, 30255.999283221838, 30441.391172176653, 31651.683483165103, 32342.029739107864, 32383.838080809444, 3338.532605435241, 3353.111425472252, 3357.1942733743726, 3364.8591320839323, 3508.19311558343, 449921.0, 454089.0, 454210.0, 454339.0, 455203.0, 64652.030219546745, 64966.67516662386, 64971.700565988416, 64995.0, 65145.0, 66997.66004679879, 67087.32912670908, 67185.99221011689, 67268.32731672718, 67383.66308168428, 17613.55966100832, 17806.287748489915, 17855.0, 17870.642587148184, 17896.194671239824, 13123.671908202372, 13151.079424440388, 13155.736885262433, 13168.868311316955, 13176.47294108244, 15484.92257538705, 15749.685006300038, 15755.921220393824, 16208.675826483404, 17152.656946861243, 5582.302212223472, 7831.608419578998, 7885.526868387915, 7906.802329941683, 7953.403494737918, 803.8826031815664, 866.6273502393905, 889.7898857553722, 902.1925376787739, 920.9639155949557, 31331.530027049157, 31541.842290788398, 31583.684163158076, 31643.525347119812, 32108.197295067344, 996.7059717383389, 1084.5444913136503, 1094.3597995172754, 1117.709395557161, 1242.3912282981455, 15513.224338783015, 15757.0, 16328.673426531403, 16471.25879335433, 16848.326066957183, 621942.0, 628433.0, 628474.0, 628777.0, 629518.0, 55429.722851385486, 56596.71701641548, 56627.43372566222, 63624.68187659032, 64076.0, 1367.7538043152128, 1392.060359257497, 1455.992720036393, 1478.4751413248573, 1504.1501551623298, 28449.28876778097, 30939.381212376076, 31530.211744706565, 33292.50061249132, 34059.65940340565, 54086.0, 54149.729251355064, 54671.453285468226, 54692.72653636865, 54870.72564637151, 543001.0, 544657.2767136297, 544794.0, 545960.0, 627551.0, 23392.0, 27877.581836272067, 28698.282542936595, 29323.41353172882, 29401.705982939897, 50296.74851625718, 50393.74803125961, 50480.24279635735, 51496.22755658743, 52207.47792522178, 40138.0, 40720.592794072865, 41331.7933410343, 42444.0, 42892.35661465018, 40546.0, 40725.0, 40983.38524922188, 42360.0, 42565.57434425616, 40314.0, 40819.795901020305, 40991.385129222486, 41133.58866411417, 41255.0, 29091.0, 32339.35321293608, 35093.29813403667, 35829.1042723934, 36338.09154771152, 24914.626280606168, 25866.35334116662, 25870.48259034771, 25891.61162582525, 26405.0], "value": 20823.12659355433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.1138005474152, 401.29372304743663, 404.5954045954046, 420.222588211808, 428.3617410059011, 20139.496512587193, 21317.36047918565, 21843.781562184373, 22212.000459979277, 22215.0, 22017.66973495399, 22312.553748925013, 22376.0, 22478.0, 22527.662085068736, 5558.99999999999, 5976.611520251192, 6029.577929544934, 6042.758289668408, 6049.1228771828055, 4274.401583778274, 4458.576435238647, 5844.736986835603, 5924.674142922137, 5965.910511342312, 4535.818567257305, 6598.472122230234, 6690.899636505456, 6692.163479565054, 6705.631190284533, 6456.515761317873, 6590.80227593173, 6680.799576012728, 6681.064650948871, 6685.665716714169, 5862.589618726691, 5866.2373891393845, 5868.09044598088, 5871.089981052944, 5883.441073098049, 27868.60656967164, 28169.732362043756, 28177.57733633997, 28182.295442613893, 28520.572191417144, 2769.127724766692, 2772.514809908278, 2796.902108426216, 2808.49447099522, 2809.887604495818, 15727.842721572752, 15759.763603545956, 15859.52421427359, 15882.76175857363, 15986.920065399598, 1852.9993803346176, 1856.6101118765075, 1860.6557786809349, 1893.214316058834, 1903.0674969265099, 123713.0, 126091.36954315261, 128913.06630400551, 130399.99999999905, 130692.34653826765, 9478.0, 11571.768564628828, 11774.764504709858, 11818.586349477728, 12425.627231182898, 15478.458253961282, 15538.922305388402, 15548.455804046804, 15554.533363999099, 15558.533244002698, 9054.230390416888, 9229.446233226028, 9272.536373181314, 9285.164335209729, 9347.392419492711, 8996.460212387277, 9065.002849686529, 9106.134917182857, 9241.953790231006, 9276.443413395218, 7496.512726672749, 7642.172396213326, 7658.65536050879, 7663.770086897402, 7675.923240767633, 1654.594624317026, 2023.5447024419682, 2030.066169562018, 2034.6337659221185, 2038.8368930485526, 400.7255030304251, 402.30803018807603, 988.7972965542046, 1031.437866362834, 1109.3565731875492, 11590.94204528972, 12100.939495302644, 12178.695532611579, 12256.44845981933, 12446.31545265001, 434.90866917946954, 437.4946936288592, 439.1743522178284, 451.8192722910862, 454.8771831605448, 5520.0, 5777.046787280052, 6199.690015499297, 6247.437730604177, 6394.296627370985, 771251.0, 772779.0, 813608.0, 815060.0, 843747.0, 149583.2520837389, 151626.0, 155590.44409555758, 155753.0, 157222.0, 1107.5514416661265, 1127.0870594818223, 1178.723000094977, 1179.3277831636058, 1185.5435657272185, 18943.715844262624, 19158.71261931044, 19796.90101549483, 20057.899710501355, 20289.391318260477, 63218.0, 63280.36719632929, 64125.71748565096, 64533.67733161304, 64628.67685661541, 70981.0, 94011.82934938645, 94307.58538622063, 96677.06645867183, 96731.0, 8403.873941890753, 8759.868601971102, 8848.734537963872, 8859.158379953895, 8923.598438070432, 9859.901400985898, 11262.0, 13147.342632868127, 13355.732885342433, 13925.651858703613, 10901.781964360827, 11280.32318060919, 11411.657650270505, 11499.482523286304, 11629.0, 11297.604583839526, 11337.09303255721, 11424.885751142383, 11622.07023438106, 11653.6503904883, 6199.597026193283, 8675.869861952202, 11412.771744565229, 11436.828447573127, 11764.941175294069, 8418.242358187792, 8570.74287771368, 8757.649694012169, 8822.911770882209, 8882.467051976902, 9755.0, 10770.51532681047, 11603.0, 11769.058475321783, 11787.882121179022], "value": 9829.377636381865, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.349888306405, 1372.5127579709197, 1385.2450414524083, 1443.6318738721627, 1488.4343949299264, 7639.618019099051, 8098.352131829454, 8354.665813367457, 8355.039170495387, 8460.830783384328, 8224.05423376312, 8308.50148991061, 8338.624761885714, 8343.791405214874, 8351.20663536963, 2109.997751068238, 2389.581823180945, 2443.9857459154427, 2450.13020377766, 2454.3864033991504, 2211.402921211272, 2222.677711731798, 2229.57638048771, 2232.330300909721, 2366.928992130239, 2407.590709579367, 2419.697537807774, 2420.624803155505, 2421.2131057406327, 2431.112643884987, 2340.9648855267183, 2379.381360846175, 2382.5115851250453, 2386.5226954608975, 2389.593769059264, 2346.483773569812, 2351.376885125443, 2406.470576473173, 2409.903603855844, 2414.7223069346896, 8531.0, 8595.054544000155, 8595.968483781924, 8601.95699021507, 8629.784255393603, 5142.125838607446, 5272.92090618641, 5284.524392804666, 5287.86780330491, 5302.337207849019, 3523.273595937972, 3550.627184145679, 3556.87550935716, 3566.5006899034156, 3601.891943241707, 1263.759885621729, 1274.840644919385, 1289.6711338608595, 1313.6321829887647, 1329.242331870834, 11074.0, 11109.388983605899, 11112.333260004345, 11122.721931951684, 11145.777084458347, 4670.673052886334, 4786.569208771228, 4859.878503037382, 4871.050145221648, 4905.877353066202, 9776.413415195111, 9780.755481113029, 9788.314817962817, 9797.216222702167, 9848.950755246322, 5404.8108316208745, 5430.402655707869, 5434.619576629677, 5438.211459338374, 5439.912017596496, 4777.641676874248, 4790.401199850019, 4876.073546026244, 4925.433575138905, 4992.675476094042, 3604.567451905788, 3671.7796932184156, 3673.008287762289, 3864.0, 3922.490076290121, 1057.7567159553191, 1156.2888823373733, 1157.0859021373021, 1160.1125139268465, 1199.280431740966, 721.6932803558572, 798.5833825214374, 952.7522844060594, 959.8896126945351, 999.0958182844392, 5655.830325090254, 5709.400512946164, 5848.035074212792, 5893.850699113717, 5959.0763431668165, 916.8853893263342, 954.4464210757744, 1011.3426272922659, 1076.0530732954949, 1079.1528650009705, 3067.7699172562147, 3761.6614504694708, 3797.6771974382486, 4084.101497670508, 4109.0, 10002.099811017044, 10352.430616316175, 10357.63748268807, 10364.326318789255, 10383.428911409945, 9247.583858726239, 9613.759656008655, 10154.339967902062, 10377.429241391796, 10412.68761937143, 6987.161540615159, 7799.80500487481, 8127.024757029194, 8179.959100204461, 8196.590170491452, 5665.235193248858, 5686.2607860977805, 5732.828015159552, 5848.883022339444, 5920.615160014585, 9270.351075424656, 9285.257179425495, 9365.953170234377, 9388.76528086776, 9424.198943089914, 7296.854062918818, 8988.415752976036, 9354.0, 9598.0, 9603.90396096058, 6817.181938167451, 6903.75836845708, 6925.861482770216, 6980.127484064492, 7024.648767561499, 8000.759977200693, 8083.919160808552, 8101.946746923098, 8104.5137291762685, 8130.146334635015, 7115.85768284621, 7301.817454563678, 7309.159446663702, 7406.222346653739, 7412.888806667796, 7031.824204394931, 7127.643617819192, 7192.208857025618, 7242.6740796663225, 7290.088738907637, 6489.059086432535, 6590.275069742229, 6648.368405001517, 6653.268140504444, 6654.401103900672, 5044.621653376085, 5059.558025962583, 5089.185730283137, 5095.878641964801, 5343.278657381359, 3796.430535419709, 5115.386153661584, 5117.744112794271, 5256.894862102813, 5352.197170424468], "value": 4498.136237133248, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.3551224672065, 357.6763029458341, 368.15875723970714, 374.90252534341096, 380.4635463995765, 4368.213721530124, 4707.411573553301, 5023.221400682891, 5141.434442211354, 5319.0, 4202.474690663667, 4940.505949405057, 5019.899602007967, 5036.445990940993, 5189.546926860476, 3290.720288775445, 3308.8676452941854, 3719.7396182267253, 4124.814383352741, 4126.607972242639, 3228.0, 3508.561429821272, 4035.639151096612, 4079.3676980068135, 4115.279826030448, 3613.855445782179, 3682.650148235913, 4049.6760259179196, 4070.168424209118, 4080.9795951020205, 4066.8779936601654, 4091.509018917749, 4117.279476091687, 4125.030617804813, 4131.173765246963, 3565.5008298838184, 3597.8740744074094, 3609.693176080036, 3637.963620363789, 3645.106948797535, 4932.446279421971, 5090.49095090488, 5097.872553186163, 5121.308623335839, 5163.108659150887, 3976.7613943163215, 4290.039872487973, 4745.715257084586, 4757.833475828329, 4787.784549695272, 4403.075354175627, 4769.856904292877, 5538.944610553924, 5559.416261292547, 5579.066757935646, 3375.8143302118374, 4025.9798701006603, 4038.9296836338394, 4040.4747382840337, 4104.56902025286, 5103.362079740033, 5205.7397130143345, 5597.45315881273, 5826.1552074948895, 5908.143319218732, 3749.850005999784, 4082.408050832613, 4097.918041639151, 4101.179764047202, 4110.17796440713, 4134.793260336971, 4176.206520761046, 4189.769562674082, 4228.788560571959, 4237.749863790128, 3793.7534060285993, 4670.705395010312, 4737.336772851803, 4752.453467851172, 4777.829431789234, 4492.573205545468, 5640.351359593617, 5651.400355836361, 5665.603407761417, 5665.631733937281, 1125.876153623101, 1327.561904571489, 1328.8006798980036, 1354.3634491788844, 1373.642852858264, 813.7802793245909, 892.1569117184199, 923.8106188231396, 924.5977999570208, 928.178561972659, 4506.918339598473, 4549.681522293474, 4653.769841269841, 5057.317262169634, 5239.685618862881, 4976.129177393942, 5616.494515493625, 5639.731060511353, 5664.291963504562, 5726.885462290814, 4632.305154226893, 5094.490550944876, 5174.327337446108, 5204.375474943031, 5217.50433708797, 2405.592728253991, 2508.786753126005, 2683.9329016774345, 2771.974369483304, 2788.707185745508, 5413.675179489164, 5502.669839809624, 5548.5838562108, 5550.888982220333, 5551.666899986014, 4685.976570117127, 5016.423111342169, 5261.736913154327, 5495.505404513613, 5541.778328866801, 5022.497750225021, 5228.398734145546, 5364.597655175956, 5605.439456054443, 5634.464725851038, 4822.614190864792, 5102.948970510396, 5224.712640804641, 5385.434529374359, 5448.891022179613, 4986.675866068694, 5170.844874653766, 5177.689338639693, 5359.946400535945, 5385.946140538545, 4989.077020751172, 5574.9163762542785, 5663.433656634304, 5680.460356266148, 5726.856828579319, 3323.30210655765, 3397.745169112277, 3688.6536414208085, 3705.4071348585176, 3858.401947698111, 4881.413540599248, 4920.704757714549, 5188.22176673502, 5471.972640136773, 5542.528885044655, 4339.609435150852, 4406.074724307931, 4921.163402221559, 5137.460566640449, 5365.59758018158, 4216.451861258017, 4372.387865698868, 4555.40779698637, 4587.38070360497, 4920.384951881015, 4267.997020700195, 4391.604755572014, 4695.12652062057, 4920.458749537476, 5080.796768129381, 5129.0, 5144.742762861917, 5370.865728356823, 5376.784928602969, 5581.665100093845, 4791.137595232892, 4843.951560484491, 5082.364704411949, 5474.671519708831, 5485.314335708036], "value": 3973.6625627703697, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.8124243969249, 766.1304419483885, 791.9128895821459, 871.3856731004643, 888.3026823943206, 15137.772933405993, 15693.607659808496, 15700.21498925055, 15700.528984130466, 15710.607234819106, 14339.0, 14367.568972930829, 14470.5658830235, 14472.204028778413, 14486.130832150078, 698.106423777563, 709.0498731699522, 725.1226016520017, 878.3193025405315, 884.1379654836547, 714.7033980897921, 895.9328050396214, 907.6596276396351, 908.2552307108174, 909.9808214799434, 963.7831487915198, 965.4400447740329, 966.5553845231202, 968.0368033806373, 970.0638883477443, 959.1032384720239, 960.4381436859445, 960.4957397366369, 961.9947155222809, 962.6341990043809, 720.2221600671314, 720.718919621348, 722.1009842745763, 722.4653756220412, 722.7145277615313, 15488.5353439397, 15736.606584835356, 15859.762103568455, 15940.840591594051, 16340.264688089064, 15147.469838555708, 15480.0, 15482.845171548253, 15542.922285388613, 15656.686866262611, 11809.527618895234, 11873.643790686207, 11913.702157446047, 12019.51921923122, 12146.817797733042, 3803.315403227418, 3814.713896457749, 3822.4648549203134, 3962.663173630216, 3967.8016099195215, 95983.0, 102557.0, 102804.97195028029, 108085.45957270241, 112809.99999999919, 11101.222914396076, 11539.365334906493, 11724.413779311, 11780.410979450993, 11794.646160615195, 24033.399165020666, 24235.636465453033, 24236.1517346892, 24316.513669726508, 24695.753042469347, 7802.570858602831, 7924.167962363868, 7954.125046244909, 8268.0, 8310.875336869953, 4381.846635367747, 4392.802323895432, 4417.447819022622, 4505.43682039745, 4618.261078227468, 3597.640235976434, 3674.9081272967856, 3691.390920498088, 3705.2033812729856, 3711.406175012039, 662.7050962321721, 667.3326673326674, 669.1201070592156, 680.9863802724017, 683.3883674111643, 599.5503372470647, 662.8607992321666, 666.5249229886842, 669.3540733192395, 669.8392385827366, 8450.61972211252, 9419.293552983554, 9533.0, 10026.0, 10197.0, 645.5094128462403, 658.90116482528, 690.3648643248123, 698.3679769808332, 713.1228588835761, 4837.37114175155, 4864.586510146677, 4887.36464259644, 4909.435414927258, 4926.968381897086, 104560.47719761352, 106769.4661526703, 109379.0, 109703.35444968332, 109965.45017274862, 72996.0, 85619.57190214009, 94974.0502594979, 96566.51716741371, 96730.0326996721, 61410.69294653588, 67086.0, 80334.0, 84730.57634711787, 87222.0, 9593.328467007243, 9620.278479113955, 9670.274729395183, 9679.951600241953, 9733.0, 47291.0, 49503.25745113898, 52294.0, 53455.0, 55546.0, 72581.27418725746, 73542.0, 73697.0, 74821.0, 75505.24494754981, 11535.942320288344, 11771.117166212398, 11968.401579921143, 12012.819807703067, 12135.575254866037, 12159.270443773403, 12236.388180591113, 12442.315672638091, 12709.428075736429, 13134.211947283193, 10491.213159012952, 10915.454227288763, 11019.231441833328, 11092.722681933015, 11501.48243329069, 11727.648170554898, 11824.172307938707, 11837.112216583619, 11880.643580692593, 12434.875651243734, 11201.0, 11873.643790686294, 11902.0, 12033.157678962738, 12166.391680415767, 9580.66467673628, 9901.207903367569, 9956.303058785816, 10136.442495662513, 10172.28793984414, 9783.559739811868, 9852.050609305577, 9895.703128906145, 9946.950265248917, 11592.304461732323], "value": 7501.966781206245, "unit": "score"}], "name": "dromaeo_css", "value": 7363.517914475663, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 115.0, 116.0, 113.0, 116.0, 115.0, 116.0, 116.0, 116.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 109.0, 108.0, 144.0, 109.0, 108.0, 108.0, 107.0, 129.0, 139.0], "value": 120.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 188.0, 184.0, 186.0, 185.0, 185.0, 183.0, 184.0, 184.0, 186.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 57.0, 89.0, 61.0, 59.0, 58.0, 58.0, 71.0, 57.0], "value": 65.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 86.0, 68.0, 68.0, 71.0, 81.0, 67.0, 68.0, 80.0], "value": 74.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 86.0, 89.0, 84.0, 89.0, 86.0, 89.0, 130.0], "value": 91.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 108.0, 151.0], "value": 101.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 91.0, 88.0, 86.0, 87.0, 92.0, 124.0, 84.0], "value": 91.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 54.0, 55.0, 55.0, 57.0, 56.0, 56.0, 56.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 70.0, 75.0, 73.0, 70.0, 70.0, 71.0, 71.0, 72.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 83.0, 83.0, 83.0, 79.0, 80.0, 85.0, 89.0, 101.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 133.0, 130.0, 131.0, 132.0, 130.0, 134.0, 187.0, 140.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 163.0, 164.0, 162.0, 161.0, 166.0, 164.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 63.0, 66.0, 66.0, 82.0, 84.0, 80.0, 84.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1427.9, "alertThreshold": 2.0}]} 14:26:14 INFO - Return code: 0 14:26:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:26:14 INFO - # TBPL SUCCESS # 14:26:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:26:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:26:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:26:14 INFO - 2017-03-23 14:26:14.940 screenresolution[6985:127944] starting screenresolution argv=screenresolution get 14:26:14 INFO - 2017-03-23 14:26:14.943 screenresolution[6985:127944] Display 0: 1600x1200x32@60 14:26:14 INFO - 2017-03-23 14:26:14.949 screenresolution[6986:127947] starting screenresolution argv=screenresolution list 14:26:14 INFO - Available Modes on Display 0 14:26:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:26:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:26:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:26:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:26:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:26:15 INFO - Intel Iris: 14:26:15 INFO - Chipset Model: Intel Iris 14:26:15 INFO - Type: GPU 14:26:15 INFO - Bus: Built-In 14:26:15 INFO - VRAM (Dynamic, Max): 1536 MB 14:26:15 INFO - Vendor: Intel (0x8086) 14:26:15 INFO - Device ID: 0x0a2e 14:26:15 INFO - Revision ID: 0x0009 14:26:15 INFO - Displays: 14:26:15 INFO - Display: 14:26:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:26:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:26:15 INFO - Display Serial Number: 1600x1200 60 14:26:15 INFO - Main Display: Yes 14:26:15 INFO - Mirror: Off 14:26:15 INFO - Online: Yes 14:26:15 INFO - Rotation: Supported 14:26:15 INFO - Return code: 0 14:26:15 INFO - Running post-action listener: _resource_record_post_action 14:26:15 INFO - [mozharness: 2017-03-23 21:26:15.186127Z] Finished run-tests step (success) 14:26:15 INFO - Running post-run listener: _resource_record_post_run 14:26:15 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 479744; Write bytes: 421403136; Read time: 7; Write time: 1499 14:26:15 INFO - TinderboxPrint: CPU usage
53.6% 14:26:15 INFO - TinderboxPrint: I/O read bytes / time
479,744 / 7 14:26:15 INFO - TinderboxPrint: I/O write bytes / time
421,403,136 / 1,499 14:26:15 INFO - TinderboxPrint: CPU idle
2,210.8 (46.4%) 14:26:15 INFO - TinderboxPrint: CPU system
958.1 (20.1%) 14:26:15 INFO - TinderboxPrint: CPU user
1,600.7 (33.6%) 14:26:15 INFO - TinderboxPrint: Swap in / out
121,757,696 / 0 14:26:15 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121471488; Write bytes: 116724736; Read time: 11195; Write time: 300 14:26:15 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 274432; Write bytes: 294540800; Read time: 3; Write time: 1164 14:26:15 INFO - Running post-run listener: _upload_blobber_files 14:26:15 INFO - Blob upload gear active. 14:26:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:26:15 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:26:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:26:16 INFO - (blobuploader) - INFO - Open directory for files ... 14:26:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:26:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:26:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:16 INFO - (blobuploader) - INFO - Done attempting. 14:26:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:26:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:17 INFO - (blobuploader) - INFO - Done attempting. 14:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:26:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:18 INFO - (blobuploader) - INFO - Done attempting. 14:26:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:26:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:26:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:20 INFO - (blobuploader) - INFO - Done attempting. 14:26:20 INFO - (blobuploader) - INFO - Iteration through files over. 14:26:20 INFO - Return code: 0 14:26:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:26:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:26:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d88ed91d7440d66d974f79df7b1c301e0d232d514a82f6b14dbf98474c9b4b4ff7247dac632443d5ba9a69882a15fde2a3f5bd17047ea1bc16c002e332b56b70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07dc1c5297c6469dd13c14928397e41fc7ef63f0d64b6451c148c1808977678e98ab45a10fc6149f6e1e7ee3f2b4a95abb546ef62fa9f11974fdba3fe7ee15ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75a9d71fbe03a56ab35c45b849b07e21dda17c90ce97a6b94bcf8e417ba7a1c728b15d2ba5d4d6e14372d3c4cdc67a646f6b50ca98c73e20667210acb4bae6c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/faaf9f2570596c5e9c6f1c8538a8fc0ab274d4c6df496375c752c5653803d447bfe18ae0771c009245e6df1d3bc0e12f5750e51eacdefbe712935cffeca010e3"} 14:26:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:26:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:26:20 INFO - Contents: 14:26:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d88ed91d7440d66d974f79df7b1c301e0d232d514a82f6b14dbf98474c9b4b4ff7247dac632443d5ba9a69882a15fde2a3f5bd17047ea1bc16c002e332b56b70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07dc1c5297c6469dd13c14928397e41fc7ef63f0d64b6451c148c1808977678e98ab45a10fc6149f6e1e7ee3f2b4a95abb546ef62fa9f11974fdba3fe7ee15ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75a9d71fbe03a56ab35c45b849b07e21dda17c90ce97a6b94bcf8e417ba7a1c728b15d2ba5d4d6e14372d3c4cdc67a646f6b50ca98c73e20667210acb4bae6c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/faaf9f2570596c5e9c6f1c8538a8fc0ab274d4c6df496375c752c5653803d447bfe18ae0771c009245e6df1d3bc0e12f5750e51eacdefbe712935cffeca010e3"} 14:26:20 INFO - Running post-run listener: copy_logs_to_upload_dir 14:26:20 INFO - Copying logs to upload dir... 14:26:20 INFO - mkdir: /builds/slave/test/build/upload/logs 14:26:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.408606 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-23 14:26:20.759675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 14:26:20.764024) ========= 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.WfQsPhESVB/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.UMsec9u6ZB/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d88ed91d7440d66d974f79df7b1c301e0d232d514a82f6b14dbf98474c9b4b4ff7247dac632443d5ba9a69882a15fde2a3f5bd17047ea1bc16c002e332b56b70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07dc1c5297c6469dd13c14928397e41fc7ef63f0d64b6451c148c1808977678e98ab45a10fc6149f6e1e7ee3f2b4a95abb546ef62fa9f11974fdba3fe7ee15ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75a9d71fbe03a56ab35c45b849b07e21dda17c90ce97a6b94bcf8e417ba7a1c728b15d2ba5d4d6e14372d3c4cdc67a646f6b50ca98c73e20667210acb4bae6c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/faaf9f2570596c5e9c6f1c8538a8fc0ab274d4c6df496375c752c5653803d447bfe18ae0771c009245e6df1d3bc0e12f5750e51eacdefbe712935cffeca010e3"} build_url:https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/WgPwQyz0RTCygxdPGWbocw/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d88ed91d7440d66d974f79df7b1c301e0d232d514a82f6b14dbf98474c9b4b4ff7247dac632443d5ba9a69882a15fde2a3f5bd17047ea1bc16c002e332b56b70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07dc1c5297c6469dd13c14928397e41fc7ef63f0d64b6451c148c1808977678e98ab45a10fc6149f6e1e7ee3f2b4a95abb546ef62fa9f11974fdba3fe7ee15ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75a9d71fbe03a56ab35c45b849b07e21dda17c90ce97a6b94bcf8e417ba7a1c728b15d2ba5d4d6e14372d3c4cdc67a646f6b50ca98c73e20667210acb4bae6c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/faaf9f2570596c5e9c6f1c8538a8fc0ab274d4c6df496375c752c5653803d447bfe18ae0771c009245e6df1d3bc0e12f5750e51eacdefbe712935cffeca010e3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 14:26:20.799762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 14:26:20.800120) ========= 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.WfQsPhESVB/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.UMsec9u6ZB/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005572 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 14:26:20.849534) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 14:26:20.849912) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 14:26:20.850367) ========= ========= Total master_lag: 0.19 =========