builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0218 starttime: 1476096724.94 results: success (0) buildid: 20161010024717 builduid: d64dab442eb3409c8929cd7f91e4964a revision: 142098bba3d41b4a0ca6ef5bf58d6fcf5ad209fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 03:52:04.938621) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 03:52:04.939109) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 03:52:04.939403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 03:52:04.961968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 03:52:04.962326) ========= 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.qwz2WolpNv/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.klwNTMYKTD/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 --2016-10-10 03:52:04-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-10-10 03:52:05 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.412761 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 03:52:05.396973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 03:52:05.397301) ========= 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.qwz2WolpNv/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.klwNTMYKTD/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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.020923 ========= master_lag: 0.60 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 03:52:06.013289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-10 03:52:06.013647) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 142098bba3d41b4a0ca6ef5bf58d6fcf5ad209fc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 142098bba3d41b4a0ca6ef5bf58d6fcf5ad209fc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qwz2WolpNv/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.klwNTMYKTD/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 2016-10-10 03:52:06,095 truncating revision to first 12 chars 2016-10-10 03:52:06,095 Setting DEBUG logging. 2016-10-10 03:52:06,095 attempt 1/10 2016-10-10 03:52:06,095 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/142098bba3d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 03:52:07,683 unpacking tar archive at: mozilla-central-142098bba3d4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.866748 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-10 03:52:07.903414) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 03:52:07.903721) ========= script_repo_revision: 142098bba3d41b4a0ca6ef5bf58d6fcf5ad209fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 03:52:07.904113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 03:52:07.904376) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 03:52:07.922621) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-10 03:52:07.923111) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qwz2WolpNv/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.klwNTMYKTD/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 03:52:08 INFO - MultiFileLogger online at 20161010 03:52:08 in /builds/slave/test 03:52:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:52:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:52:08 INFO - {'append_to_log': False, 03:52:08 INFO - 'base_work_dir': '/builds/slave/test', 03:52:08 INFO - 'blob_upload_branch': 'Firefox', 03:52:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:52:08 INFO - 'branch': 'Firefox', 03:52:08 INFO - 'buildbot_json_path': 'buildprops.json', 03:52:08 INFO - 'config_files': ('talos/mac_config.py',), 03:52:08 INFO - 'default_actions': ('clobber', 03:52:08 INFO - 'read-buildbot-config', 03:52:08 INFO - 'download-and-extract', 03:52:08 INFO - 'populate-webroot', 03:52:08 INFO - 'create-virtualenv', 03:52:08 INFO - 'install', 03:52:08 INFO - 'run-tests'), 03:52:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:52:08 INFO - 'download_minidump_stackwalk': True, 03:52:08 INFO - 'download_symbols': 'ondemand', 03:52:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:52:08 INFO - 'tooltool.py': '/tools/tooltool.py', 03:52:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:52:08 INFO - '/tools/misc-python/virtualenv.py')}, 03:52:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:52:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:52:08 INFO - 'installer_path': 'installer.exe', 03:52:08 INFO - 'log_level': 'info', 03:52:08 INFO - 'log_name': 'talos', 03:52:08 INFO - 'log_to_console': True, 03:52:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:52:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:52:08 INFO - 'opt_config_files': (), 03:52:08 INFO - 'pip_index': False, 03:52:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:52:08 INFO - 'cmd': ('bash', 03:52:08 INFO - '-c', 03:52:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:52:08 INFO - 'enabled': True, 03:52:08 INFO - 'halt_on_failure': False, 03:52:08 INFO - 'name': 'check_screen_resolution'},), 03:52:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:52:08 INFO - 'cmd': ('bash', 03:52:08 INFO - '-c', 03:52:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:52:08 INFO - 'enabled': True, 03:52:08 INFO - 'halt_on_failure': False, 03:52:08 INFO - 'name': 'check_screen_resolution'},), 03:52:08 INFO - 'run_cmd_checks_enabled': True, 03:52:08 INFO - 'sps_profile': False, 03:52:08 INFO - 'sps_profile_interval': 0, 03:52:08 INFO - 'suite': 'dromaeojs', 03:52:08 INFO - 'system_bits': '32', 03:52:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:52:08 INFO - 'title': 't-yosemite-r7-0218', 03:52:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:52:08 INFO - 'use_talos_json': True, 03:52:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:52:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:52:08 INFO - 'work_dir': 'build'} 03:52:08 INFO - [mozharness: 2016-10-10 10:52:08.126418Z] Running clobber step. 03:52:08 INFO - Running pre-action listener: _resource_record_pre_action 03:52:08 INFO - Running main action method: clobber 03:52:08 INFO - rmtree: /builds/slave/test/build 03:52:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:52:09 INFO - Running post-action listener: _resource_record_post_action 03:52:09 INFO - [mozharness: 2016-10-10 10:52:09.630668Z] Finished clobber step (success) 03:52:09 INFO - [mozharness: 2016-10-10 10:52:09.630855Z] Running read-buildbot-config step. 03:52:09 INFO - Running pre-action listener: _resource_record_pre_action 03:52:09 INFO - Running main action method: read_buildbot_config 03:52:09 INFO - Using buildbot properties: 03:52:09 INFO - { 03:52:09 INFO - "project": "", 03:52:09 INFO - "product": "firefox", 03:52:09 INFO - "script_repo_revision": "production", 03:52:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:52:09 INFO - "repository": "", 03:52:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:52:09 INFO - "buildid": "20161010024717", 03:52:09 INFO - "pgo_build": "False", 03:52:09 INFO - "basedir": "/builds/slave/test", 03:52:09 INFO - "buildnumber": 1, 03:52:09 INFO - "slavename": "t-yosemite-r7-0218", 03:52:09 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:52:09 INFO - "platform": "yosemite_r7", 03:52:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:52:09 INFO - "branch": "mozilla-central", 03:52:09 INFO - "repo_path": "mozilla-central", 03:52:09 INFO - "revision": "142098bba3d41b4a0ca6ef5bf58d6fcf5ad209fc", 03:52:09 INFO - "stage_platform": "macosx64", 03:52:09 INFO - "builduid": "d64dab442eb3409c8929cd7f91e4964a", 03:52:09 INFO - "slavebuilddir": "test" 03:52:09 INFO - } 03:52:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 03:52:09 INFO - Running post-action listener: _resource_record_post_action 03:52:09 INFO - [mozharness: 2016-10-10 10:52:09.634202Z] Finished read-buildbot-config step (success) 03:52:09 INFO - [mozharness: 2016-10-10 10:52:09.634293Z] Running download-and-extract step. 03:52:09 INFO - Running pre-action listener: _resource_record_pre_action 03:52:09 INFO - Running main action method: download_and_extract 03:52:09 INFO - mkdir: /builds/slave/test/build/tests 03:52:09 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')]} 03:52:09 INFO - trying https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 03:52:09 INFO - Downloading https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:52:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 03:52:10 INFO - Downloaded 1199 bytes. 03:52:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:52:10 INFO - Using the following test package requirements: 03:52:10 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:52:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:52:10 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 03:52:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:52:10 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 03:52:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:52:10 INFO - u'jsshell-mac.zip'], 03:52:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:52:10 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 03:52:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:52:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:52:10 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 03:52:10 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:52:10 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 03:52:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:52:10 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 03:52:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:52:10 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 03:52:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:52:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:52:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:52:10 INFO - Fetch https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:52:11 INFO - Http code: 200 03:52:11 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 03:52:11 INFO - x-amz-cf-id: 1s-pUu4Em6GecJ6kjMkrbqdzomEzcAbfen7FeoYDNT9j__eYSahH_A== 03:52:11 INFO - x-amz-version-id: yoUCaT09NGCNTsEhvsxY2xr6nKoKLp4X 03:52:11 INFO - Expected file size: 16496340 03:52:11 INFO - Obtained file size: 16496340 03:52:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:52:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:52:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:52:18 INFO - Fetch https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:52:18 INFO - Http code: 200 03:52:18 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 03:52:18 INFO - x-amz-cf-id: zt7l0yybB4wvbc6unxh8UwwCsZFA_Q64yU-s-dVJrFCfY7CNreW5wg== 03:52:18 INFO - x-amz-version-id: yoUCaT09NGCNTsEhvsxY2xr6nKoKLp4X 03:52:19 INFO - Expected file size: 16496340 03:52:19 INFO - Obtained file size: 16496340 03:52:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 03:52:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:52:25 INFO - Fetch https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 03:52:26 INFO - Http code: 200 03:52:26 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 03:52:26 INFO - x-amz-cf-id: uhpq0kMVy-RXacyGQdBPOrPefWvsqECKxavcsuLObQG2VINFa739vA== 03:52:26 INFO - x-amz-version-id: WOc0E9d1.8RuD8D3UnxU.ak1y9Uffxe9 03:52:26 INFO - Expected file size: 14409006 03:52:26 INFO - Obtained file size: 14409006 03:52:27 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')]} 03:52:27 INFO - trying https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:52:27 INFO - Downloading https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 03:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 03:52:29 INFO - Downloaded 111710495 bytes. 03:52:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:52:29 INFO - mkdir: /builds/slave/test/properties 03:52:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:52:29 INFO - Writing to file /builds/slave/test/properties/build_url 03:52:29 INFO - Contents: 03:52:29 INFO - build_url:https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:52:30 INFO - Running post-action listener: _resource_record_post_action 03:52:30 INFO - Running post-action listener: set_extra_try_arguments 03:52:30 INFO - [mozharness: 2016-10-10 10:52:30.596670Z] Finished download-and-extract step (success) 03:52:30 INFO - [mozharness: 2016-10-10 10:52:30.596810Z] Running populate-webroot step. 03:52:30 INFO - Running pre-action listener: _resource_record_pre_action 03:52:30 INFO - Running main action method: populate_webroot 03:52:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:52:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:52:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:52:30 INFO - '--tppagecycles', 03:52:30 INFO - '7'], 03:52:30 INFO - 'tests': ['tsvgm']}}, 03:52:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:52:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:52:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:52:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:52:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:52:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:52:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:30 INFO - 'talos_options': ['--disable-e10s'], 03:52:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:30 INFO - 'talos_options': ['--disable-e10s'], 03:52:30 INFO - 'tests': ['damp', 'tps']}, 03:52:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:30 INFO - 'tests': ['damp', 'tps']}, 03:52:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:52:30 INFO - 'tests': ['dromaeo_dom']}, 03:52:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:52:30 INFO - 'tests': ['basic_compositor_video']}, 03:52:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:52:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:52:30 INFO - 'tests': ['a11yr', 03:52:30 INFO - 'ts_paint', 03:52:30 INFO - 'tpaint', 03:52:30 INFO - 'sessionrestore', 03:52:30 INFO - 'sessionrestore_no_auto_restore', 03:52:30 INFO - 'tabpaint']}, 03:52:30 INFO - 'other-e10s': {'tests': ['a11yr', 03:52:30 INFO - 'ts_paint', 03:52:30 INFO - 'tpaint', 03:52:30 INFO - 'sessionrestore', 03:52:30 INFO - 'sessionrestore_no_auto_restore', 03:52:30 INFO - 'tabpaint']}, 03:52:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:52:30 INFO - 'ts_paint', 03:52:30 INFO - 'tpaint', 03:52:30 INFO - 'sessionrestore', 03:52:30 INFO - 'sessionrestore_no_auto_restore', 03:52:30 INFO - 'tabpaint']}, 03:52:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:52:30 INFO - 'ts_paint', 03:52:30 INFO - 'tpaint', 03:52:30 INFO - 'sessionrestore', 03:52:30 INFO - 'sessionrestore_no_auto_restore', 03:52:30 INFO - 'tabpaint']}, 03:52:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:52:30 INFO - 'tests': ['a11yr', 03:52:30 INFO - 'ts_paint', 03:52:30 INFO - 'tpaint', 03:52:30 INFO - 'sessionrestore', 03:52:30 INFO - 'sessionrestore_no_auto_restore', 03:52:30 INFO - 'tabpaint']}, 03:52:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:52:30 INFO - 'tests': ['a11yr', 03:52:30 INFO - 'ts_paint', 03:52:30 INFO - 'tpaint', 03:52:30 INFO - 'sessionrestore', 03:52:30 INFO - 'sessionrestore_no_auto_restore', 03:52:30 INFO - 'tabpaint']}, 03:52:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:52:30 INFO - 'tests': ['tsvgx', 03:52:30 INFO - 'tsvgr_opacity', 03:52:30 INFO - 'tart', 03:52:30 INFO - 'tscrollx', 03:52:30 INFO - 'cart']}, 03:52:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:52:30 INFO - 'tsvgr_opacity', 03:52:30 INFO - 'tart', 03:52:30 INFO - 'tscrollx', 03:52:30 INFO - 'cart']}, 03:52:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:30 INFO - 'talos_options': ['--disable-e10s'], 03:52:30 INFO - 'tests': ['tp5o']}, 03:52:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:30 INFO - 'tests': ['tp5o']}, 03:52:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:30 INFO - 'talos_options': ['--disable-e10s', 03:52:30 INFO - '--xperf_path', 03:52:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:30 INFO - 'tests': ['tp5n']}, 03:52:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:30 INFO - 'talos_options': ['--xperf_path', 03:52:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:30 INFO - 'tests': ['tp5n']}}, 03:52:30 INFO - 'talos.zip': {'path': '', 03:52:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:52:30 INFO - Running post-action listener: _resource_record_post_action 03:52:30 INFO - [mozharness: 2016-10-10 10:52:30.616175Z] Finished populate-webroot step (success) 03:52:30 INFO - [mozharness: 2016-10-10 10:52:30.616304Z] Running create-virtualenv step. 03:52:30 INFO - Running pre-action listener: _resource_record_pre_action 03:52:30 INFO - Running main action method: create_virtualenv 03:52:30 INFO - Creating virtualenv /builds/slave/test/build/venv 03:52:30 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 03:52:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:52:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:30 INFO - Using real prefix '/tools/python27' 03:52:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:31 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:34 INFO - Installing pip.................done. 03:52:34 INFO - Return code: 0 03:52:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:52:34 INFO - Reading from file tmpfile_stdout 03:52:34 INFO - Output received: 03:52:34 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) 03:52:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52:34 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')]} 03:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:34 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')]} 03:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:34 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 0x108814490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd339475c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108628d30>, '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 0x10844edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108620b20>, '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.qwz2WolpNv/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.klwNTMYKTD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 03:52:34 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 03:52:34 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 03:52:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qwz2WolpNv/Render', 03:52:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:34 INFO - 'HOME': '/Users/cltbld', 03:52:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:34 INFO - 'LOGNAME': 'cltbld', 03:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:34 INFO - 'MOZ_NO_REMOTE': '1', 03:52:34 INFO - 'NO_EM_RESTART': '1', 03:52:34 INFO - 'PAGER': '/bin/cat', 03:52:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:34 INFO - 'PWD': '/builds/slave/test', 03:52:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:34 INFO - 'SHELL': '/bin/bash', 03:52:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.klwNTMYKTD/Listeners', 03:52:34 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 03:52:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:34 INFO - 'USER': 'cltbld', 03:52:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:34 INFO - 'XPC_FLAGS': '0x0', 03:52:34 INFO - 'XPC_SERVICE_NAME': '0', 03:52:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:34 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 03:52:34 INFO - Cleaning up... 03:52:34 INFO - Return code: 0 03:52:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:52:34 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')]} 03:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:34 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')]} 03:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:34 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 0x108814490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd339475c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108628d30>, '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 0x10844edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108620b20>, '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.qwz2WolpNv/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.klwNTMYKTD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 03:52:34 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 03:52:34 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 03:52:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qwz2WolpNv/Render', 03:52:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:34 INFO - 'HOME': '/Users/cltbld', 03:52:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:34 INFO - 'LOGNAME': 'cltbld', 03:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:34 INFO - 'MOZ_NO_REMOTE': '1', 03:52:34 INFO - 'NO_EM_RESTART': '1', 03:52:34 INFO - 'PAGER': '/bin/cat', 03:52:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:34 INFO - 'PWD': '/builds/slave/test', 03:52:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:34 INFO - 'SHELL': '/bin/bash', 03:52:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.klwNTMYKTD/Listeners', 03:52:34 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 03:52:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:34 INFO - 'USER': 'cltbld', 03:52:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:34 INFO - 'XPC_FLAGS': '0x0', 03:52:34 INFO - 'XPC_SERVICE_NAME': '0', 03:52:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:35 INFO - Downloading/unpacking psutil>=3.1.1 03:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:38 INFO - Installing collected packages: psutil 03:52:38 INFO - Running setup.py install for psutil 03:52:38 INFO - building 'psutil._psutil_osx' extension 03:52:38 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 03:52:38 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 03:52:38 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 03:52:39 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 03:52:39 INFO - building 'psutil._psutil_posix' extension 03:52:39 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 03:52:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:52:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:52:39 INFO - ^ 03:52:39 INFO - 1 warning generated. 03:52:39 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 03:52:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:39 INFO - Successfully installed psutil 03:52:39 INFO - Cleaning up... 03:52:39 INFO - Return code: 0 03:52:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:52:39 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')]} 03:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:39 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')]} 03:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:39 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 0x108814490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd339475c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108628d30>, '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 0x10844edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108620b20>, '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.qwz2WolpNv/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.klwNTMYKTD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 03:52:39 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 03:52:39 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 03:52:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qwz2WolpNv/Render', 03:52:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:39 INFO - 'HOME': '/Users/cltbld', 03:52:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:39 INFO - 'LOGNAME': 'cltbld', 03:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:39 INFO - 'MOZ_NO_REMOTE': '1', 03:52:39 INFO - 'NO_EM_RESTART': '1', 03:52:39 INFO - 'PAGER': '/bin/cat', 03:52:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:39 INFO - 'PWD': '/builds/slave/test', 03:52:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:39 INFO - 'SHELL': '/bin/bash', 03:52:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.klwNTMYKTD/Listeners', 03:52:39 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 03:52:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:39 INFO - 'USER': 'cltbld', 03:52:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:39 INFO - 'XPC_FLAGS': '0x0', 03:52:39 INFO - 'XPC_SERVICE_NAME': '0', 03:52:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:52:42 INFO - Installing collected packages: mozsystemmonitor 03:52:42 INFO - Running setup.py install for mozsystemmonitor 03:52:42 INFO - Successfully installed mozsystemmonitor 03:52:42 INFO - Cleaning up... 03:52:42 INFO - Return code: 0 03:52:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:42 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 0x108814490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd339475c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108628d30>, '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 0x10844edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108620b20>, '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.qwz2WolpNv/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.klwNTMYKTD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 03:52:42 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 03:52:42 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 03:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qwz2WolpNv/Render', 03:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:42 INFO - 'HOME': '/Users/cltbld', 03:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:42 INFO - 'LOGNAME': 'cltbld', 03:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:42 INFO - 'MOZ_NO_REMOTE': '1', 03:52:42 INFO - 'NO_EM_RESTART': '1', 03:52:42 INFO - 'PAGER': '/bin/cat', 03:52:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:42 INFO - 'PWD': '/builds/slave/test', 03:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:42 INFO - 'SHELL': '/bin/bash', 03:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.klwNTMYKTD/Listeners', 03:52:42 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 03:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:42 INFO - 'USER': 'cltbld', 03:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:42 INFO - 'XPC_FLAGS': '0x0', 03:52:42 INFO - 'XPC_SERVICE_NAME': '0', 03:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:42 INFO - Downloading/unpacking jsonschema==2.5.1 03:52:42 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 03:52:42 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 03:52:42 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 03:52:42 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 03:52:42 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 03:52:42 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 03:52:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:52:45 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 03:52:45 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 03:52:45 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 03:52:45 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 03:52:45 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 03:52:45 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 03:52:45 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:45 INFO - warning: no files found matching '*.txt' 03:52:45 INFO - no previously-included directories found matching 'build' 03:52:45 INFO - no previously-included directories found matching 'dist' 03:52:45 INFO - no previously-included directories found matching '.git*' 03:52:45 INFO - Installing collected packages: jsonschema, functools32 03:52:45 INFO - Running setup.py install for functools32 03:52:46 INFO - warning: no files found matching '*.txt' 03:52:46 INFO - no previously-included directories found matching 'build' 03:52:46 INFO - no previously-included directories found matching 'dist' 03:52:46 INFO - no previously-included directories found matching '.git*' 03:52:46 INFO - Successfully installed jsonschema functools32 03:52:46 INFO - Cleaning up... 03:52:46 INFO - Return code: 0 03:52:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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')]} 03:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108814490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd339475c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108628d30>, '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 0x10844edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108620b20>, '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.qwz2WolpNv/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.klwNTMYKTD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 03:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:52:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qwz2WolpNv/Render', 03:52:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:46 INFO - 'HOME': '/Users/cltbld', 03:52:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:46 INFO - 'LOGNAME': 'cltbld', 03:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:46 INFO - 'MOZ_NO_REMOTE': '1', 03:52:46 INFO - 'NO_EM_RESTART': '1', 03:52:46 INFO - 'PAGER': '/bin/cat', 03:52:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:46 INFO - 'PWD': '/builds/slave/test', 03:52:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:46 INFO - 'SHELL': '/bin/bash', 03:52:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.klwNTMYKTD/Listeners', 03:52:46 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 03:52:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:46 INFO - 'USER': 'cltbld', 03:52:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:46 INFO - 'XPC_FLAGS': '0x0', 03:52:46 INFO - 'XPC_SERVICE_NAME': '0', 03:52:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:52:46 INFO - Cleaning up... 03:52:46 INFO - Return code: 0 03:52:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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')]} 03:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108814490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd339475c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108628d30>, '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 0x10844edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108620b20>, '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.qwz2WolpNv/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.klwNTMYKTD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 03:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:52:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qwz2WolpNv/Render', 03:52:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:46 INFO - 'HOME': '/Users/cltbld', 03:52:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:46 INFO - 'LOGNAME': 'cltbld', 03:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:46 INFO - 'MOZ_NO_REMOTE': '1', 03:52:46 INFO - 'NO_EM_RESTART': '1', 03:52:46 INFO - 'PAGER': '/bin/cat', 03:52:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:46 INFO - 'PWD': '/builds/slave/test', 03:52:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:46 INFO - 'SHELL': '/bin/bash', 03:52:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.klwNTMYKTD/Listeners', 03:52:46 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 03:52:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:46 INFO - 'USER': 'cltbld', 03:52:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:46 INFO - 'XPC_FLAGS': '0x0', 03:52:46 INFO - 'XPC_SERVICE_NAME': '0', 03:52:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:46 INFO - Downloading/unpacking blobuploader==1.2.4 03:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:49 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 INFO - Downloading docopt-0.6.1.tar.gz 03:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:50 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:50 INFO - Running setup.py install for blobuploader 03:52:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:50 INFO - Running setup.py install for requests 03:52:51 INFO - Running setup.py install for docopt 03:52:51 INFO - Successfully installed blobuploader requests docopt 03:52:51 INFO - Cleaning up... 03:52:51 INFO - Return code: 0 03:52:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:51 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')]} 03:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:51 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')]} 03:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:51 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 0x108814490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd339475c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108628d30>, '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 0x10844edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108620b20>, '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.qwz2WolpNv/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.klwNTMYKTD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 03:52:51 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 03:52:51 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 03:52:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qwz2WolpNv/Render', 03:52:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:51 INFO - 'HOME': '/Users/cltbld', 03:52:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:51 INFO - 'LOGNAME': 'cltbld', 03:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:51 INFO - 'MOZ_NO_REMOTE': '1', 03:52:51 INFO - 'NO_EM_RESTART': '1', 03:52:51 INFO - 'PAGER': '/bin/cat', 03:52:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:51 INFO - 'PWD': '/builds/slave/test', 03:52:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:51 INFO - 'SHELL': '/bin/bash', 03:52:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.klwNTMYKTD/Listeners', 03:52:51 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 03:52:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:51 INFO - 'USER': 'cltbld', 03:52:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:51 INFO - 'XPC_FLAGS': '0x0', 03:52:51 INFO - 'XPC_SERVICE_NAME': '0', 03:52:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:51 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-MTXEi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:51 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-AWmpJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:51 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-M05WtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-sD2Pza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-fMvVxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-9YGgpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-zhmRij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Z4aaKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-9BoO5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-IUxa2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-uR0qpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-UuUkMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:52 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-1rjDkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-FV_rSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-TsgomK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-AECX1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:53 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-ZsZoK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:53 INFO - Running setup.py install for manifestparser 03:52:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:53 INFO - Running setup.py install for mozcrash 03:52:53 INFO - Running setup.py install for mozdebug 03:52:53 INFO - Running setup.py install for mozdevice 03:52:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Running setup.py install for mozfile 03:52:54 INFO - Running setup.py install for mozhttpd 03:52:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Running setup.py install for mozinfo 03:52:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Running setup.py install for mozInstall 03:52:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Running setup.py install for mozleak 03:52:54 INFO - Running setup.py install for mozlog 03:52:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:54 INFO - Running setup.py install for moznetwork 03:52:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozprocess 03:52:55 INFO - Running setup.py install for mozprofile 03:52:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozrunner 03:52:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozscreenshot 03:52:55 INFO - Running setup.py install for moztest 03:52:55 INFO - Running setup.py install for mozversion 03:52:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:56 INFO - Cleaning up... 03:52:56 INFO - Return code: 0 03:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:56 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 0x108814490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd339475c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108628d30>, '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 0x10844edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108620b20>, '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.qwz2WolpNv/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.klwNTMYKTD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 03:52:56 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 03:52:56 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 03:52:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qwz2WolpNv/Render', 03:52:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:56 INFO - 'HOME': '/Users/cltbld', 03:52:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:56 INFO - 'LOGNAME': 'cltbld', 03:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:56 INFO - 'MOZ_NO_REMOTE': '1', 03:52:56 INFO - 'NO_EM_RESTART': '1', 03:52:56 INFO - 'PAGER': '/bin/cat', 03:52:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:56 INFO - 'PWD': '/builds/slave/test', 03:52:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:56 INFO - 'SHELL': '/bin/bash', 03:52:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.klwNTMYKTD/Listeners', 03:52:56 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 03:52:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:56 INFO - 'USER': 'cltbld', 03:52:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:56 INFO - 'XPC_FLAGS': '0x0', 03:52:56 INFO - 'XPC_SERVICE_NAME': '0', 03:52:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:56 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-izl6Fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:56 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:56 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-S51YR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:56 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Z9Tx_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:56 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:56 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-lUoJpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:56 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-KE1WHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:56 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:56 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-GTXCiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:56 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:56 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-J1xn0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-AMYo0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-jQTlnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-4n11rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-QYcgcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-3XAISV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-xw7YBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-dFzSnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Q3IiWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:57 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-0uI9UL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 03:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:58 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-teMPw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:58 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)) 03:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:52:58 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)) 03:52:58 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:58 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:58 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 03:52:58 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 03:52:58 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 03:52:58 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 03:52:58 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 03:52:58 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 03:53:00 INFO - Downloading blessings-1.6.tar.gz 03:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:53:00 INFO - Installing collected packages: blessings 03:53:00 INFO - Running setup.py install for blessings 03:53:00 INFO - Successfully installed blessings 03:53:00 INFO - Cleaning up... 03:53:00 INFO - Return code: 0 03:53:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:53:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:01 INFO - Reading from file tmpfile_stdout 03:53:01 INFO - Current package versions: 03:53:01 INFO - blessings == 1.6 03:53:01 INFO - blobuploader == 1.2.4 03:53:01 INFO - docopt == 0.6.1 03:53:01 INFO - functools32 == 3.2.3-2 03:53:01 INFO - jsonschema == 2.5.1 03:53:01 INFO - manifestparser == 1.1 03:53:01 INFO - mozInstall == 1.12 03:53:01 INFO - mozcrash == 0.17 03:53:01 INFO - mozdebug == 0.1 03:53:01 INFO - mozdevice == 0.48 03:53:01 INFO - mozfile == 1.2 03:53:01 INFO - mozhttpd == 0.7 03:53:01 INFO - mozinfo == 0.9 03:53:01 INFO - mozleak == 0.1 03:53:01 INFO - mozlog == 3.4 03:53:01 INFO - moznetwork == 0.27 03:53:01 INFO - mozprocess == 0.23 03:53:01 INFO - mozprofile == 0.28 03:53:01 INFO - mozrunner == 6.12 03:53:01 INFO - mozscreenshot == 0.1 03:53:01 INFO - mozsystemmonitor == 0.3 03:53:01 INFO - moztest == 0.7 03:53:01 INFO - mozversion == 1.4 03:53:01 INFO - psutil == 3.1.1 03:53:01 INFO - requests == 1.2.3 03:53:01 INFO - wsgiref == 0.1.2 03:53:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:01 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 0x108814490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd339475c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108628d30>, '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 0x10844edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108620b20>, '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.qwz2WolpNv/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.klwNTMYKTD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 03:53:01 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 03:53:01 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 03:53:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qwz2WolpNv/Render', 03:53:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:53:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:53:01 INFO - 'HOME': '/Users/cltbld', 03:53:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:53:01 INFO - 'LOGNAME': 'cltbld', 03:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:01 INFO - 'MOZ_NO_REMOTE': '1', 03:53:01 INFO - 'NO_EM_RESTART': '1', 03:53:01 INFO - 'PAGER': '/bin/cat', 03:53:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:01 INFO - 'PWD': '/builds/slave/test', 03:53:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:53:01 INFO - 'SHELL': '/bin/bash', 03:53:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.klwNTMYKTD/Listeners', 03:53:01 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 03:53:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:53:01 INFO - 'USER': 'cltbld', 03:53:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:53:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:01 INFO - 'XPC_FLAGS': '0x0', 03:53:01 INFO - 'XPC_SERVICE_NAME': '0', 03:53:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:01 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)) 03:53:01 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)) 03:53:01 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)) 03:53:01 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)) 03:53:01 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)) 03:53:01 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)) 03:53:01 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)) 03:53:01 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)) 03:53:01 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)) 03:53:01 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)) 03:53:01 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)) 03:53:01 INFO - Cleaning up... 03:53:01 INFO - Return code: 0 03:53:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108814490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10878a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd339475c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108628d30>, '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 0x10844edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108620b20>, '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.qwz2WolpNv/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.klwNTMYKTD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 03:53: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'] in /builds/slave/test/build 03:53: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 03:53:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qwz2WolpNv/Render', 03:53:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:53:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:53:02 INFO - 'HOME': '/Users/cltbld', 03:53:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:53:02 INFO - 'LOGNAME': 'cltbld', 03:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:02 INFO - 'MOZ_NO_REMOTE': '1', 03:53:02 INFO - 'NO_EM_RESTART': '1', 03:53:02 INFO - 'PAGER': '/bin/cat', 03:53:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:02 INFO - 'PWD': '/builds/slave/test', 03:53:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:53:02 INFO - 'SHELL': '/bin/bash', 03:53:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.klwNTMYKTD/Listeners', 03:53:02 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 03:53:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:53:02 INFO - 'USER': 'cltbld', 03:53:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:53:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:02 INFO - 'XPC_FLAGS': '0x0', 03:53:02 INFO - 'XPC_SERVICE_NAME': '0', 03:53:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:53:02 INFO - Cleaning up... 03:53:02 INFO - Return code: 0 03:53:02 INFO - Running post-action listener: _resource_record_post_action 03:53:02 INFO - Running post-action listener: _start_resource_monitoring 03:53:02 INFO - Starting resource monitoring. 03:53:02 INFO - [mozharness: 2016-10-10 10:53:02.647326Z] Finished create-virtualenv step (success) 03:53:02 INFO - [mozharness: 2016-10-10 10:53:02.648378Z] Running install step. 03:53:02 INFO - Running pre-action listener: _resource_record_pre_action 03:53:02 INFO - Running main action method: install 03:53:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:02 INFO - Reading from file tmpfile_stdout 03:53:02 INFO - Detecting whether we're running mozinstall >=1.0... 03:53:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:53:03 INFO - Reading from file tmpfile_stdout 03:53:03 INFO - Output received: 03:53:03 INFO - Usage: mozinstall [options] installer 03:53:03 INFO - Options: 03:53:03 INFO - -h, --help show this help message and exit 03:53:03 INFO - -d DEST, --destination=DEST 03:53:03 INFO - Directory to install application into. [default: 03:53:03 INFO - "/builds/slave/test"] 03:53:03 INFO - --app=APP Application being installed. [default: firefox] 03:53:03 INFO - mkdir: /builds/slave/test/build/application 03:53:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:53:36 INFO - Reading from file tmpfile_stdout 03:53:36 INFO - Output received: 03:53:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:53:36 INFO - Running post-action listener: _resource_record_post_action 03:53:36 INFO - [mozharness: 2016-10-10 10:53:36.876024Z] Finished install step (success) 03:53:36 INFO - [mozharness: 2016-10-10 10:53:36.876179Z] Running run-tests step. 03:53:36 INFO - Running pre-action listener: _resource_record_pre_action 03:53:36 INFO - Running main action method: run_tests 03:53:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:53:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:53:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:53:36 INFO - 2016-10-10 03:53:36.890 screenresolution[1949:13868] starting screenresolution argv=screenresolution get 03:53:36 INFO - 2016-10-10 03:53:36.893 screenresolution[1949:13868] Display 0: 1600x1200x32@60 03:53:36 INFO - 2016-10-10 03:53:36.899 screenresolution[1950:13870] starting screenresolution argv=screenresolution list 03:53:36 INFO - Available Modes on Display 0 03:53:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:53:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:53:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:53:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:53:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:53:37 INFO - Intel Iris: 03:53:37 INFO - Chipset Model: Intel Iris 03:53:37 INFO - Type: GPU 03:53:37 INFO - Bus: Built-In 03:53:37 INFO - VRAM (Dynamic, Max): 1536 MB 03:53:37 INFO - Vendor: Intel (0x8086) 03:53:37 INFO - Device ID: 0x0a2e 03:53:37 INFO - Revision ID: 0x0009 03:53:37 INFO - Displays: 03:53:37 INFO - Display: 03:53:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:53:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:53:37 INFO - Display Serial Number: 1600x1200 60 03:53:37 INFO - Main Display: Yes 03:53:37 INFO - Mirror: Off 03:53:37 INFO - Online: Yes 03:53:37 INFO - Rotation: Supported 03:53:37 INFO - Return code: 0 03:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:53:37 INFO - Python 2.7.3 03:53:37 INFO - Return code: 0 03:53:37 INFO - grabbing minidump binary from tooltool 03:53:37 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')]} 03:53:37 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 0x108628d30>, '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 0x10844edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108620b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:53:37 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 03:53:37 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 03:53:37 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 03:53:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:53:37 INFO - Return code: 0 03:53:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:53:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:53:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:53:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:53:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0218', '--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 03:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0218 --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 03:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qwz2WolpNv/Render', 03:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:53:37 INFO - 'HOME': '/Users/cltbld', 03:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:53:37 INFO - 'LOGNAME': 'cltbld', 03:53:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:53:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:37 INFO - 'MOZ_NO_REMOTE': '1', 03:53:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:53:37 INFO - 'NO_EM_RESTART': '1', 03:53:37 INFO - 'PAGER': '/bin/cat', 03:53:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:37 INFO - 'PWD': '/builds/slave/test', 03:53:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:53:37 INFO - 'SHELL': '/bin/bash', 03:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.klwNTMYKTD/Listeners', 03:53:37 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 03:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:53:37 INFO - 'USER': 'cltbld', 03:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:37 INFO - 'XPC_FLAGS': '0x0', 03:53:37 INFO - 'XPC_SERVICE_NAME': '0', 03:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:53:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0218', '--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 03:53:37 INFO - mozversion application_buildid: 20161010024717 03:53:37 INFO - mozversion application_changeset: 142098bba3d41b4a0ca6ef5bf58d6fcf5ad209fc 03:53:37 INFO - mozversion application_display_name: Nightly 03:53:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:53:37 INFO - mozversion application_name: Firefox 03:53:37 INFO - mozversion application_remotingname: firefox 03:53:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:53:37 INFO - mozversion application_vendor: Mozilla 03:53:37 INFO - mozversion application_version: 52.0a1 03:53:37 INFO - mozversion platform_buildid: 20161010024717 03:53:37 INFO - mozversion platform_changeset: 142098bba3d41b4a0ca6ef5bf58d6fcf5ad209fc 03:53:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:53:37 INFO - mozversion platform_version: 52.0a1 03:53:37 INFO - using testdate: 1476096817 03:53:37 INFO - actual date: 1476096817 03:53:37 INFO - starting webserver on 'localhost:50897' 03:53:37 INFO - SUITE-START | Running 2 tests 03:53:37 INFO - TEST-START | dromaeo_css 03:53:37 INFO - operating with platform_type : mac_ 03:53:37 INFO - Initialising browser for dromaeo_css test... 03:53:37 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpX01J_B/profile http://localhost:50897/getInfo.html) 03:53:39 INFO - PROCESS | 1960 | __metrics Screen width/height:1600/1200 03:53:39 INFO - PROCESS | 1960 | colorDepth:24 03:53:39 INFO - PROCESS | 1960 | Browser inner width/height: 1024/689 03:53:39 INFO - PROCESS | 1960 | __metrics 03:53:39 INFO - PROCESS | 1960 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:53:39 INFO - PROCESS | 1960 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:53:40 INFO - TEST-INFO | 1960: exit 0 03:53:40 INFO - Browser initialized. 03:53:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:53:40 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpX01J_B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:52 INFO - PROCESS | 1962 | RSS: Main: 234905600 03:53:52 INFO - PROCESS | 1962 | 03:54:44 INFO - PROCESS | 1962 | 1476096884115 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:56:54 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50897/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50897/tests/dromaeo/cssquery-ext.html) 03:56:57 INFO - PROCESS | 1962 | RSS: Main: 452702208 03:56:57 INFO - PROCESS | 1962 | 04:00:00 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50897/tests/dromaeo/cssquery-ext.html (next: http://localhost:50897/tests/dromaeo/cssquery-jquery.html) 04:00:01 INFO - PROCESS | 1962 | RSS: Main: 369090560 04:00:01 INFO - PROCESS | 1962 | 04:03:03 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50897/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50897/tests/dromaeo/cssquery-mootools.html) 04:03:04 INFO - PROCESS | 1962 | RSS: Main: 336637952 04:03:04 INFO - PROCESS | 1962 | 04:06:06 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50897/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50897/tests/dromaeo/cssquery-prototype.html) 04:06:07 INFO - PROCESS | 1962 | RSS: Main: 357994496 04:06:07 INFO - PROCESS | 1962 | 04:09:10 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50897/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50897/tests/dromaeo/cssquery-yui.html) 04:09:11 INFO - PROCESS | 1962 | RSS: Main: 337534976 04:09:11 INFO - PROCESS | 1962 | 04:12:14 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50897/tests/dromaeo/cssquery-yui.html (next: http://localhost:50897/tests/dromaeo/cssquery-dojo.html) 04:12:14 INFO - PROCESS | 1962 | RSS: Main: 510164992 04:12:14 INFO - PROCESS | 1962 | 04:12:14 INFO - PROCESS | 1962 | __start_tp_report 04:12:14 INFO - PROCESS | 1962 | _x_x_mozilla_page_load 04:12:14 INFO - PROCESS | 1962 | _x_x_mozilla_page_load_details 04:12:14 INFO - PROCESS | 1962 | |i|pagename|runs| 04:12:14 INFO - PROCESS | 1962 | |0;dojo.html;3263.4125857345675;3284.9507257391138;3317.0878008547647;3341.64663311359;3360.3279344131165;5520.585956053292;5603.187537807015;5638.605297629168;5678.034734095203;5682.346530149034;5636.7181640918;5649.915251271234;5733;5737.856553586152;5759.366469688342;5065.214891691794;5115.769790359443;5120.897582048376;5170.457102004292;5183.015227106856;5263.657862238962;5281.524662780349;5288.762005709733;5305.602079844008;5311.070562651521;5259.263703081571;5270.39390470097;5298.788048478056;5308.920366194491;5354.544863686591;4314.61168494837;5106.540411362995;5148.021875843578;5169;5170.870728231786;5146.150885103953;5149.356330458692;5160.329157209576;5178.533931946143;5219.399769026534;4886.682365646222;5578.023845826964;5707.6575405475805;5715.504371934344;5737.598368114233;6073.058675905242;6115.788007244199;6142.017277235621;6226.159468471744;6232.781852635136;6179.969100154515;6181.072839074175;6228.470580000705;6242.843928901769;6267.341929097424;5753.654780713171;5767.36558978512;5778.248827652463;5796.927568399901;5818.505427038707;6099.491378240913;6143.170671959318;6171.56799024064;6208.50331973441;6219.471344935731;5494.780208791683;5920.993431116721;6109.101029780167;6126.479249263863;6138.202033735586;6177.660228687465;6179.876402471926;6181.041938499539;6194.721237544321;6198.659073750897;6015.969920150371;6036.366181550961;6193.969030154821;6197.1324014637985;6197.876042479125;6109.266887973472;6125.142480052797;6161.876762464725;6170.629762214281;6192.81421557354;4947.134251505972;4951.257311403247;4956.628252881048;4971.477994810565;4993.076280888047;4418.5802348776815;4440.955590444119;4462.107578484316;4473.396091527602;4477.3731677565165;4733.408323959505;5574.721263936787;5614.943850561442;5665.518430933417;5687;6245.718942647592;6264.498840092781;6275.843103922347;6279.654618995908;6282.994720844643;5398.541124004425;5712.857178570486;5715.799947001919;5726.341470730836;5727.684977326204;5245.580353571705;5291.153415453509;5330.893382132335;5397.298351214396;5398.406175320712;6175.505959523317;6224.688765561613;6234.75060997555;6260.092286618324;6264.686765661608;5273.815416460406;6255.155554000152;6276.780312689034;6283.088952102011;6285.685715714288;6145.907811382744;6204.5967012144065;6205.47253483459;6241.719122639583;6249.218847644044;4933.629977751755;6062.575619706578;6086.02623580225;6125.23545181825;6144.433169541917;5730.799422020209;5908.670549126412;6146.262448506208;6206.906896396467;6251.437370636664;6077.331493535796;6093;6108.11432342299;6122.877542449037;6131.448169664752;5921.3190483094995;5985.521158307412;5997.760089596367;6086.3305036446845;6113.02191649334;5839.883202336015;5884.911726324194;5903.498202652822;5915.290165180206;5916.881662366643;6016.42843929826;6022.638641681513;6030.095485677183;6046.062860256668;6053.303870055;5863.970680146572;5872.794452194153;5879.970600146972;5883.058710606282;5892.381299963442 04:12:14 INFO - PROCESS | 1962 | |1;ext.html;444.45776153093215;510.8084468324378;534.794104269856;539.2235181338872;547.7097138516585;41074.58925410745;42381;42614.147717045715;42651.14697706044;43558.34662480057;42764.572354276446;43143.568564314344;43195.568044319545;43212.3518147228;43316.318112960354;8857.468551886908;9094.63621455141;9789.951050244757;9975.551100200471;9987.650432234874;11999.52001919922;12308.446119924625;12367.876321236807;12375.690607734789;12507.687307817287;12272.447739851728;12332.93833530831;12343.19769214998;12354.135210535265;12374.071944604191;8935.776605584848;9144;12085.214461060003;12199.14605977582;12236.204646697935;11873;11974.34141122238;12056.156069075168;12079.758404831942;12088.09339299556;39085.41371879424;39348.40977385342;39391.60608393937;39409;39479.40780888289;3255.300110476259;3273.508973653947;3289.342131573671;3334.7999120052873;3373.561437013197;25295.747042529707;30547.541786873215;31013.689863101306;31779.52330715041;31918.20204494883;3304.7025767680784;3312.3044160726276;3361.445361515347;3412.215190506173;3425.7773244739014;458670.3728515272;459167;459391;462019;462626;59515.51211219667;59861.70069149626;59913.700431497564;59945.70027149836;60111;63530;63620.68189659022;63665.36334636687;63669.68165159145;63680.68159659172;15866.175389830318;16084.517464476085;16088.597785055466;16101.75847362267;16108.436204732778;11172.664820055412;11389.715257118638;11402.657920262405;12188.390580470941;12286.324252166038;16821.158942052847;16889.915550422415;16991.150442477825;16992.150392480573;16996.235169417407;6286.876195900327;6408.750293692685;6726.932730672728;6797.966010169917;6889.622075584903;881.850085485469;938.3384713776771;968.4770224079059;981.4297124600724;1004.1665417703289;28815;29845.10464686063;29917;30497;30631.846840765655;842.751388340441;921.2629896083107;1042.598599539183;1064.2709743825503;1089.8692156941058;15090.698186036218;15513.534593962198;15647.452339168074;15819.762703559456;15916.840831591768;567306;571624;574457;576612;577972;56359.71820140873;56396;56426;56477.870442590916;56660;1292.6768307923019;1352.3441131051432;1355.708522667631;1358.1986627889592;1360.53741727813;29483;29519.26201844971;29708;30451.543226851172;30475.390492190476;55268.44731552633;56121.71939140278;56188.43811561832;58290.417095828496;58375;592305;598120;598756;598831;599426;26075.608865867405;26430.603540946515;26518.469630607666;26572.7342726578;26580;35683;38750.2974537956;44419.33370999502;46960;49585.75207124086;31513;38235.42646860244;38687.03282417962;38717.03207419725;39325;38592.42111368388;38710.80644596759;39690;39757.60242397655;40024.799876000434;37364.813175933945;38077;38119.618803812715;38397.6160238394;38614;33283.66716332806;34079.82960085184;34889.302213955074;34946.65053349434;35050.9484715459;25368.98524059017;25395.87302063478;25485;25960.350991225372;26010.73989260159 04:12:14 INFO - PROCESS | 1962 | |2;jquery.html;348.23909757180564;352.8747294710376;365.3679135096282;374.8463130116652;383.1627893053679;15041.699166016686;15291.311890964906;15854.84145158548;20337.59324813503;20863.582728345424;20037;20357.694634580494;20744.792552074476;20974.685379719318;21064.157433702672;5671.914921276184;5769.221155144054;6057.787977420791;6068.059450785136;6069.271687397519;5032.396112466509;5404.432534583871;5982.670953097578;5990.430909063632;6010.519158467312;5780.653160810344;5780.884382312352;5862.836795723134;5914.497267732248;5936.3173235077875;5774.2782152230975;5897.292324921015;5902.1146827976145;5904.439078287577;5905.940940590582;4675.760923355314;4734.786934587917;5142.562882155022;5150.948490515084;5185.533302002837;25129.371765706004;25587;25619.743802561923;25641.974321027137;25934.481310373685;2181.182056728727;2308.0306271366067;2325.9534809303887;2353.446939969106;2953.1731115287753;15668.529944101696;15773.763393549107;16051.357945682159;16114.355425782955;16180.514584562481;1574.645704716441;1752.8860624059523;1785.9821401786076;1843.4930394141584;1862.1992543206416;84539.32361400353;93001.53499232461;109569;109598;110579.44710276397;10383.63657272007;10748.516316765608;10821.67534973952;10946;11071.335719856674;13419.463221471031;13436.328183590782;13445.260510672008;13458.192508449525;13473.663158421117;8310.418270721113;8446.915530844735;8459.450135741157;8476.194761497647;8656.61045252965;8402.747917562483;8413.284870785928;8444.394117675965;8586.613602387908;8594.097619749962;5973.522118230531;6043.697815109227;6588.374104460068;6605;6633.777684475658;1578.3923189572097;1827.1321122466989;1858.9070546472622;1859.748933893934;1862.07827125571;862.6549380247951;866.1554983890657;892.2326798952895;946.758576562972;998.3560603410759;20085.49358798067;20920.79079209219;21417.46456338573;22281.55436891253;22364.329070127922;883.5935469683889;904.2901322461836;967.9516024198762;969.413504829582;974.9025097490194;9480.525973701288;11070.169737269576;11806.17356785034;11831.349275789915;11921.88078119225;551789;561042;567468;575911;578459;73436.53126937432;86608.56695716607;95743.12770616893;110616.4469177665;115672.48128871765;932.4125800745622;959.4339339789558;1013.1641395848454;1014.523174108168;1015.279151802214;19660.410187694393;19945.301914432926;19969.25518198914;20113.094910729345;20120.698189527462;47851.76074119607;48921.510784891696;49671;50467.73830654263;51422.22866657078;69277.30722692709;69644.60710785857;71930;72186.27813722006;76252.23747762451;6614.801555953329;7740.961295193488;7951.642176101974;8071.717489887826;8084.191580842104;11446.542138314375;12563.811542826683;12821.743565128458;13011;13289.534866279633;10981.780364392827;11098.778024439627;11172.553097875994;11477.598284060017;11528.962393384636;10830.296030757976;11038.558457661604;11192.656881174311;11270.549178032787;11459.140564457532;11108.833367499656;11271.125862904906;11414.885851141382;11461.541538338373;11517.308961462339;7785;8009.959950200212;8071.959640201761;8258.958705206436;8307.792305192419;10293.691189264335;11032.834507482234;11185;11257.831132532854;11295.943520282675 04:12:14 INFO - PROCESS | 1962 | |3;mootools.html;1418.14911053368;1524.5578782153177;1719.509939667195;1891.6216756648673;1905.2664724081233;8295.585220738962;8795.780105497366;8813.867791983126;8817.985931617857;8856;6580.835479113024;7759.612019399022;8041.075276343222;8621.439606425578;8638.611262493187;2297.2074634251157;2327.208749025331;2330.498942727313;2332.3586013846243;2335.065973610561;2270.0919632147106;2295.850769699964;2298.643710224918;2299.12633199384;2313.4332088638307;2313.53729254149;2330.2543186180346;2345.9765402346015;2346;2350;2046.7441569803775;2196.6929676842256;2302.4243939015246;2305.0779688124717;2314.0743702518957;2296.666983287414;2298.597745394566;2299.6320588705726;2301.3786277704926;2305.227748704186;8677.479351238946;8736.170063843989;8785.428947118417;8788.60451279694;8811.206991370807;5173.068847607429;5333.253344531769;5342.1452567589;5349.866253343658;5350.250964864922;3411.181316484051;3486.9476957845654;3617.385044542434;3633.5639723233116;3636.5817930938015;1021.7037059252808;1054.2146101154613;1060.3531845574194;1076.784643071381;1079.4818487126145;11364.715882103013;11446.885531144666;11463.656090317303;11470.713232169095;11472.196946213768;3707.4253490708443;4049.311617025113;4502.527234640381;4644.722701257181;4672.042231342567;9817.901820981842;9823.754406139904;9824.164945979672;9827.4103553787;9859.014098590083;5249.501297376743;5311.176767601028;5312.335958005249;5326.201069839555;5340.385855626652;3869.5743468218475;4382.956170438319;4466.9106617867465;4559.680822342404;4895.31465594817;3760.21743909505;3786.5456145262747;3916.177602703407;3938.212357528506;3949.7037722170953;1248.431963456625;1270.142653708743;1273.4587800184884;1282.1217466035796;1282.2626989481087;825.2984962781708;890.496869268861;899.470899470902;912.885889263842;949.8981181829046;5484.314460692413;5786.537077033827;5833.125031245262;5876.500497457679;5927.081302398135;432.7446806384248;444.5532240098745;446.85030514777264;450.4189595421869;451.98418055367904;3346.8995930122137;3418.9145271367915;3920.3727403615285;3935.8622448214173;4054.1486287879284;10284.28010039305;10548.525316360781;10688.144948404264;10689.412082335546;10690.786184276427;10203.438810865473;10389.896101038892;10594.576216951236;10602.992715691997;10616.203784716177;7922.405819563441;8006.3995200360205;8022.318102961197;8110.716124935599;8113.959430202811;5565.944340556704;5652.971735141298;5700.429957004267;5764.827055188351;5882.911566394039;9588.041195880356;9794.804103918024;9859.01409859037;9892.85160722604;9915.752106197402;8918.420302680304;10105.646302379382;10113.89886101159;10114.29199955996;10116.342437741818;6749.3250674932115;7019.824504387431;7397.926020739939;7470.477066605503;7514.361279291322;7731.690732370867;7933.523988560705;8077.03075630928;8238.794030149054;8335.124811894664;7264.164621068645;7377.8524429510035;7402.111746590228;7477.588732619758;7539.208383119693;7266.709331626887;7273.127224732854;7278.526895751759;7313.817154571178;7361.30067643573;6592.044153597797;6624.370684784938;6710.530262881747;6713.261541230363;6726.226483954408;4782.593479554277;4847.563719265283;4854.466008738966;4927.827526036572;5002.874928126826;4594.196015697306;4885.65800393969;4950.727709975986;4976.776045077908;5036.471170527042 04:12:14 INFO - PROCESS | 1962 | |4;prototype.html;301.8686871211023;304.1210900497561;311.0745532042174;316.8304956848087;319.5558174137947;4883.780229889655;5181.93218323616;5316.813911513098;5335.772772262382;5363.383210930744;4194.916101677964;4409.184300904327;4945.208766597336;5094;5299.8410047698635;3228.8547015384247;3849.749766265184;3950.7629542227414;3954.5056867891512;3958.9802050989706;3109.891153809617;3394.456886898097;4004.3982407037274;4006.1987602479476;4087.05997620546;3717.070732316921;3939.428782826503;3959.1685745993377;3963.8810835674976;3973.7019723520707;3281.1305004173673;3966.690991972642;3980.6417422431973;3983.820728067215;4010.63904248619;2856.985715071432;3419.316136772655;3432.3821712091813;3434.1242983039415;3440.7935523868646;5053;5063.772130254148;5112.948870511284;5118.769655365518;5148.665336753099;4175.498940127174;4379.474463064453;4481.2381895077915;4528.5245049270015;4552.863414097583;4543.273076307808;4767.927216376288;5007.799688012475;5507.476789704971;5543.143047079193;3194;3233.6604656510963;3751.606081361445;3760.4547340635454;3785.318642644323;5642.746076426571;5686.891056244075;5764.682942438206;5802.854928626776;5803.738831752581;3207.4226639205167;3344.8996530104137;3352.8994130176134;3808.7811900191673;3817.3892177251505;3866.7679939203736;3867.5358956925347;3877.7479463835325;3898.3762597984187;3900.804959752001;3737.3459644562095;4540.977295113504;4547.613452856478;4551.340055691906;4566.406367172246;5166.535011848951;5516;5526.47498487643;5533;5591.776328946878;1306.6537367597593;1323.4706117553055;1329.3419757220238;1329.6875234319928;1330.6673331667084;825.1789469477787;850.910654381281;862.6678728689375;898.7573355194061;906.1029580715044;5184.7407629618365;5226.863881671043;5235.712035837989;5261.500157485033;5295.338082739658;4378.912421751611;4965.627577931669;5648.237487939158;5660.8867822643315;5855.355910849803;4901.456041346964;5074.619403544749;5174.97412512935;5182.792688292426;5236.622378565804;2489.875506224718;2688.448867982059;2764.847933363684;3003.5432815085105;3020.7281344679086;5586.860328491739;5678.630888992202;5858.681796595817;5883.499902508334;5946.702664866826;4772.403449568804;5738.5982981191755;5809.838032393453;5850.268716410449;5876.853078673067;5878.382769809194;5899.911501327483;5931.466168044896;5943.227380440515;5952.226210592682;4793.496682848251;4881.536254055859;5163.709072731817;5270.104082306094;5671.319441667027;5055.115354812967;5142.562882154909;5366.946330536644;5411.512963833274;5604.019296623156;4941.65408421407;5131.560545821441;5175.948240517547;5754.683492407958;5798.623089499169;3153.5585018097026;3198.584184056058;3636.618155093677;3791.8104094795704;3825.5983121771815;4323.416338794348;4936.901261974812;5564.38791732901;5588.898161520396;5608.541779137372;5510.972445137749;5573.219749235192;5581.609287349846;5585.553155747449;5587.525060369914;5149.9742501287255;5472.482657977375;5483.561315094863;5514.531264842533;5622.550195984393;4279.529251782364;4521.412216411845;5393.784248630011;5393.83818485446;5433.347998240237;5311.3891902431715;5452.5365343946205;5600.179941519104;5647.209390685225;5748.798792042426;4805.495422980537;5129.435762066244;5463.972680136733;5484.753186106715;5532.5297349724115 04:12:14 INFO - PROCESS | 1962 | |5;yui.html;714.303554034816;719.6186021408652;770.6031393832177;814.8655471847145;824.9010118785746;15276.083434993894;16107.83892161078;16158.192090395463;16172.757408638865;16523.173841307947;14538.709225815477;14652.340644670989;14654.48709295175;14667.92666036671;14683;673.1484671890063;695.9269276725947;695.9838635592016;842.4818736477054;847.9491230526188;866.9133086691344;871.2898987325341;878.9296856251517;880.8590625499921;882.5587206396801;934.5747684803398;936.1060187520901;936.2369668720005;936.3679516326487;938.1228551304553;926.157196950775;927.0821886332483;928.2944961829058;928.7956649537091;929.1498279074673;534.8769782949944;553.2033871225423;665.72705190872;684.1960696182016;689.2556039477353;15240;15270.16014119223;15281.770773438408;15289.6177595561;15311.157886316249;12672.493100275979;13664.316784160752;13849.099808512516;14117.505887293895;14142.292885355691;12473.75052498954;12527.74944501114;12705.237685738884;12734.80897786534;13294.86705132946;4545.886352841172;4602.861914142581;4656.4877863434995;4696.295555666643;4708.246680531133;103707.48146259296;103748.48125759399;103879.9224015523;103978.48010759974;104235;10621.787564248672;10717.124503212062;11028.28316159447;11159.776804464027;11498.94250528742;19370.515737106685;20072.69527480738;21509.784902151092;21559.92200389974;21569.892150539148;7560.206178351194;7579.962100189574;7679.116901556393;7722.11195712489;7795.103563090203;4126.793660316972;4192.350185721218;4260.318349064135;4282.528921818597;4365.519792822787;3376.7805092668896;3478.704310133616;3490.528778614905;3491.982540087334;3493.5807703075793;627.3350248736355;629.5215636116584;633.654658211276;636.9808905732835;655;601.3385276196236;603.9335673076046;608.2002167150183;618.9473894718909;634.3719717479662;8413.70552030676;8733.257673097858;8890.73327800167;8982.416142950688;9028.232600228923;533.3919331961567;533.6851257757942;572.27892855003;620.4354037825557;626.674129452682;4265.573442655772;4380.452443444569;4405.867823965286;4437.755923424178;4500.639948804088;100006;100158.49920750495;102606.48696756469;149478;157419.21290393473;86207;89429.21141577132;90202;112508.87491124983;124919.37540312241;80348;100493.49753251333;100737;109991;112570.43714781538;9227.907720922705;9504.382215155993;9677.661281855102;9683.41899486033;9777.902220977983;49830.75084624554;54051.72974135104;60259.79480410455;61917.66576339613;62012;79976;84714.9171049739;94617.52691236499;96539.51730241584;97940;12748.235105893677;12973.935130324666;13080.607581772561;13088.803667944798;13395.464181433023;14511.1293322401;14664.853351466349;14703.705925881637;14928.02967807089;15138.016028958082;13299.933500332436;13764.449422023006;13913.721725565634;13915.791263130859;14075.788863167265;10822.626961178807;13720.86279137196;13730.65673358174;13868.098573592684;13873.861261387257;10076.445795481026;12636.936815315865;12841;13312.667183320495;13331.733365332446;11056.889431105586;11180.401553825866;11466.369349685847;11504.769904602028;11654.417279136178;8365.790855228668;10000.949900260368;10149.086582207638;10180.098741394766;11543.076553875502 04:12:14 INFO - PROCESS | 1962 | __end_tp_report 04:12:14 INFO - PROCESS | 1962 | __start_cc_report 04:12:14 INFO - PROCESS | 1962 | _x_x_mozilla_cycle_collect,2797 04:12:14 INFO - PROCESS | 1962 | __end_cc_report 04:12:14 INFO - PROCESS | 1962 | __startTimestamp1476097934469__endTimestamp 04:12:14 INFO - PROCESS | 1962 | 04:12:14 INFO - PROCESS | 1962 | ------- Summary: start ------- 04:12:14 INFO - PROCESS | 1962 | Number of tests: 6 04:12:14 INFO - PROCESS | 1962 | 04:12:14 INFO - PROCESS | 1962 | [#0] dojo.html Cycles:165 Average:5675.50 Median:5879.97 stddev:637.73 (10.8%) stddev-sans-first:610.97 04:12:14 INFO - PROCESS | 1962 | Values: 3263.4 3285.0 3317.1 3341.6 3360.3 5520.6 5603.2 5638.6 5678.0 5682.3 5636.7 5649.9 5733.0 5737.9 5759.4 5065.2 5115.8 5120.9 5170.5 5183.0 5263.7 5281.5 5288.8 5305.6 5311.1 5259.3 5270.4 5298.8 5308.9 5354.5 4314.6 5106.5 5148.0 5169.0 5170.9 5146.2 5149.4 5160.3 5178.5 5219.4 4886.7 5578.0 5707.7 5715.5 5737.6 6073.1 6115.8 6142.0 6226.2 6232.8 6180.0 6181.1 6228.5 6242.8 6267.3 5753.7 5767.4 5778.2 5796.9 5818.5 6099.5 6143.2 6171.6 6208.5 6219.5 5494.8 5921.0 6109.1 6126.5 6138.2 6177.7 6179.9 6181.0 6194.7 6198.7 6016.0 6036.4 6194.0 6197.1 6197.9 6109.3 6125.1 6161.9 6170.6 6192.8 4947.1 4951.3 4956.6 4971.5 4993.1 4418.6 4441.0 4462.1 4473.4 4477.4 4733.4 5574.7 5614.9 5665.5 5687.0 6245.7 6264.5 6275.8 6279.7 6283.0 5398.5 5712.9 5715.8 5726.3 5727.7 5245.6 5291.2 5330.9 5397.3 5398.4 6175.5 6224.7 6234.8 6260.1 6264.7 5273.8 6255.2 6276.8 6283.1 6285.7 6145.9 6204.6 6205.5 6241.7 6249.2 4933.6 6062.6 6086.0 6125.2 6144.4 5730.8 5908.7 6146.3 6206.9 6251.4 6077.3 6093.0 6108.1 6122.9 6131.4 5921.3 5985.5 5997.8 6086.3 6113.0 5839.9 5884.9 5903.5 5915.3 5916.9 6016.4 6022.6 6030.1 6046.1 6053.3 5864.0 5872.8 5880.0 5883.1 5892.4 04:12:14 INFO - PROCESS | 1962 | 04:12:14 INFO - PROCESS | 1962 | [#1] ext.html Cycles:180 Average:68390.12 Median:38098.31 stddev:145897.93 (383.0%) stddev-sans-first:146218.02 04:12:14 INFO - PROCESS | 1962 | Values: 444.5 510.8 534.8 539.2 547.7 41074.6 42381.0 42614.1 42651.1 43558.3 42764.6 43143.6 43195.6 43212.4 43316.3 8857.5 9094.6 9790.0 9975.6 9987.7 11999.5 12308.4 12367.9 12375.7 12507.7 12272.4 12332.9 12343.2 12354.1 12374.1 8935.8 9144.0 12085.2 12199.1 12236.2 11873.0 11974.3 12056.2 12079.8 12088.1 39085.4 39348.4 39391.6 39409.0 39479.4 3255.3 3273.5 3289.3 3334.8 3373.6 25295.7 30547.5 31013.7 31779.5 31918.2 3304.7 3312.3 3361.4 3412.2 3425.8 458670.4 459167.0 459391.0 462019.0 462626.0 59515.5 59861.7 59913.7 59945.7 60111.0 63530.0 63620.7 63665.4 63669.7 63680.7 15866.2 16084.5 16088.6 16101.8 16108.4 11172.7 11389.7 11402.7 12188.4 12286.3 16821.2 16889.9 16991.2 16992.2 16996.2 6286.9 6408.8 6726.9 6798.0 6889.6 881.9 938.3 968.5 981.4 1004.2 28815.0 29845.1 29917.0 30497.0 30631.8 842.8 921.3 1042.6 1064.3 1089.9 15090.7 15513.5 15647.5 15819.8 15916.8 567306.0 571624.0 574457.0 576612.0 577972.0 56359.7 56396.0 56426.0 56477.9 56660.0 1292.7 1352.3 1355.7 1358.2 1360.5 29483.0 29519.3 29708.0 30451.5 30475.4 55268.4 56121.7 56188.4 58290.4 58375.0 592305.0 598120.0 598756.0 598831.0 599426.0 26075.6 26430.6 26518.5 26572.7 26580.0 35683.0 38750.3 44419.3 46960.0 49585.8 31513.0 38235.4 38687.0 38717.0 39325.0 38592.4 38710.8 39690.0 39757.6 40024.8 37364.8 38077.0 38119.6 38397.6 38614.0 33283.7 34079.8 34889.3 34946.7 35050.9 25369.0 25395.9 25485.0 25960.4 26010.7 04:12:14 INFO - PROCESS | 1962 | 04:12:14 INFO - PROCESS | 1962 | [#2] jquery.html Cycles:180 Average:32690.18 Median:14443.83 stddev:93757.13 (649.1%) stddev-sans-first:93988.69 04:12:14 INFO - PROCESS | 1962 | Values: 348.2 352.9 365.4 374.8 383.2 15041.7 15291.3 15854.8 20337.6 20863.6 20037.0 20357.7 20744.8 20974.7 21064.2 5671.9 5769.2 6057.8 6068.1 6069.3 5032.4 5404.4 5982.7 5990.4 6010.5 5780.7 5780.9 5862.8 5914.5 5936.3 5774.3 5897.3 5902.1 5904.4 5905.9 4675.8 4734.8 5142.6 5150.9 5185.5 25129.4 25587.0 25619.7 25642.0 25934.5 2181.2 2308.0 2326.0 2353.4 2953.2 15668.5 15773.8 16051.4 16114.4 16180.5 1574.6 1752.9 1786.0 1843.5 1862.2 84539.3 93001.5 109569.0 109598.0 110579.4 10383.6 10748.5 10821.7 10946.0 11071.3 13419.5 13436.3 13445.3 13458.2 13473.7 8310.4 8446.9 8459.5 8476.2 8656.6 8402.7 8413.3 8444.4 8586.6 8594.1 5973.5 6043.7 6588.4 6605.0 6633.8 1578.4 1827.1 1858.9 1859.7 1862.1 862.7 866.2 892.2 946.8 998.4 20085.5 20920.8 21417.5 22281.6 22364.3 883.6 904.3 968.0 969.4 974.9 9480.5 11070.2 11806.2 11831.3 11921.9 551789.0 561042.0 567468.0 575911.0 578459.0 73436.5 86608.6 95743.1 110616.4 115672.5 932.4 959.4 1013.2 1014.5 1015.3 19660.4 19945.3 19969.3 20113.1 20120.7 47851.8 48921.5 49671.0 50467.7 51422.2 69277.3 69644.6 71930.0 72186.3 76252.2 6614.8 7741.0 7951.6 8071.7 8084.2 11446.5 12563.8 12821.7 13011.0 13289.5 10981.8 11098.8 11172.6 11477.6 11529.0 10830.3 11038.6 11192.7 11270.5 11459.1 11108.8 11271.1 11414.9 11461.5 11517.3 7785.0 8010.0 8072.0 8259.0 8307.8 10293.7 11032.8 11185.0 11257.8 11295.9 04:12:14 INFO - PROCESS | 1962 | 04:12:14 INFO - PROCESS | 1962 | [#3] mootools.html Cycles:180 Average:5577.40 Median:4851.01 stddev:3162.37 (65.2%) stddev-sans-first:3155.80 04:12:14 INFO - PROCESS | 1962 | Values: 1418.1 1524.6 1719.5 1891.6 1905.3 8295.6 8795.8 8813.9 8818.0 8856.0 6580.8 7759.6 8041.1 8621.4 8638.6 2297.2 2327.2 2330.5 2332.4 2335.1 2270.1 2295.9 2298.6 2299.1 2313.4 2313.5 2330.3 2346.0 2346.0 2350.0 2046.7 2196.7 2302.4 2305.1 2314.1 2296.7 2298.6 2299.6 2301.4 2305.2 8677.5 8736.2 8785.4 8788.6 8811.2 5173.1 5333.3 5342.1 5349.9 5350.3 3411.2 3486.9 3617.4 3633.6 3636.6 1021.7 1054.2 1060.4 1076.8 1079.5 11364.7 11446.9 11463.7 11470.7 11472.2 3707.4 4049.3 4502.5 4644.7 4672.0 9817.9 9823.8 9824.2 9827.4 9859.0 5249.5 5311.2 5312.3 5326.2 5340.4 3869.6 4383.0 4466.9 4559.7 4895.3 3760.2 3786.5 3916.2 3938.2 3949.7 1248.4 1270.1 1273.5 1282.1 1282.3 825.3 890.5 899.5 912.9 949.9 5484.3 5786.5 5833.1 5876.5 5927.1 432.7 444.6 446.9 450.4 452.0 3346.9 3418.9 3920.4 3935.9 4054.1 10284.3 10548.5 10688.1 10689.4 10690.8 10203.4 10389.9 10594.6 10603.0 10616.2 7922.4 8006.4 8022.3 8110.7 8114.0 5565.9 5653.0 5700.4 5764.8 5882.9 9588.0 9794.8 9859.0 9892.9 9915.8 8918.4 10105.6 10113.9 10114.3 10116.3 6749.3 7019.8 7397.9 7470.5 7514.4 7731.7 7933.5 8077.0 8238.8 8335.1 7264.2 7377.9 7402.1 7477.6 7539.2 7266.7 7273.1 7278.5 7313.8 7361.3 6592.0 6624.4 6710.5 6713.3 6726.2 4782.6 4847.6 4854.5 4927.8 5002.9 4594.2 4885.7 4950.7 4976.8 5036.5 04:12:14 INFO - PROCESS | 1962 | 04:12:14 INFO - PROCESS | 1962 | [#4] prototype.html Cycles:180 Average:4427.82 Median:5059.44 stddev:1390.85 (27.5%) stddev-sans-first:1359.84 04:12:14 INFO - PROCESS | 1962 | Values: 301.9 304.1 311.1 316.8 319.6 4883.8 5181.9 5316.8 5335.8 5363.4 4194.9 4409.2 4945.2 5094.0 5299.8 3228.9 3849.7 3950.8 3954.5 3959.0 3109.9 3394.5 4004.4 4006.2 4087.1 3717.1 3939.4 3959.2 3963.9 3973.7 3281.1 3966.7 3980.6 3983.8 4010.6 2857.0 3419.3 3432.4 3434.1 3440.8 5053.0 5063.8 5112.9 5118.8 5148.7 4175.5 4379.5 4481.2 4528.5 4552.9 4543.3 4767.9 5007.8 5507.5 5543.1 3194.0 3233.7 3751.6 3760.5 3785.3 5642.7 5686.9 5764.7 5802.9 5803.7 3207.4 3344.9 3352.9 3808.8 3817.4 3866.8 3867.5 3877.7 3898.4 3900.8 3737.3 4541.0 4547.6 4551.3 4566.4 5166.5 5516.0 5526.5 5533.0 5591.8 1306.7 1323.5 1329.3 1329.7 1330.7 825.2 850.9 862.7 898.8 906.1 5184.7 5226.9 5235.7 5261.5 5295.3 4378.9 4965.6 5648.2 5660.9 5855.4 4901.5 5074.6 5175.0 5182.8 5236.6 2489.9 2688.4 2764.8 3003.5 3020.7 5586.9 5678.6 5858.7 5883.5 5946.7 4772.4 5738.6 5809.8 5850.3 5876.9 5878.4 5899.9 5931.5 5943.2 5952.2 4793.5 4881.5 5163.7 5270.1 5671.3 5055.1 5142.6 5366.9 5411.5 5604.0 4941.7 5131.6 5175.9 5754.7 5798.6 3153.6 3198.6 3636.6 3791.8 3825.6 4323.4 4936.9 5564.4 5588.9 5608.5 5511.0 5573.2 5581.6 5585.6 5587.5 5150.0 5472.5 5483.6 5514.5 5622.6 4279.5 4521.4 5393.8 5393.8 5433.3 5311.4 5452.5 5600.2 5647.2 5748.8 4805.5 5129.4 5464.0 5484.8 5532.5 04:12:14 INFO - PROCESS | 1962 | 04:12:14 INFO - PROCESS | 1962 | [#5] yui.html Cycles:180 Average:22726.11 Median:4159.57 stddev:34693.56 (834.1%) stddev-sans-first:34751.52 04:12:14 INFO - PROCESS | 1962 | Values: 714.3 719.6 770.6 814.9 824.9 15276.1 16107.8 16158.2 16172.8 16523.2 14538.7 14652.3 14654.5 14667.9 14683.0 673.1 695.9 696.0 842.5 847.9 866.9 871.3 878.9 880.9 882.6 934.6 936.1 936.2 936.4 938.1 926.2 927.1 928.3 928.8 929.1 534.9 553.2 665.7 684.2 689.3 15240.0 15270.2 15281.8 15289.6 15311.2 12672.5 13664.3 13849.1 14117.5 14142.3 12473.8 12527.7 12705.2 12734.8 13294.9 4545.9 4602.9 4656.5 4696.3 4708.2 103707.5 103748.5 103879.9 103978.5 104235.0 10621.8 10717.1 11028.3 11159.8 11498.9 19370.5 20072.7 21509.8 21559.9 21569.9 7560.2 7580.0 7679.1 7722.1 7795.1 4126.8 4192.4 4260.3 4282.5 4365.5 3376.8 3478.7 3490.5 3492.0 3493.6 627.3 629.5 633.7 637.0 655.0 601.3 603.9 608.2 618.9 634.4 8413.7 8733.3 8890.7 8982.4 9028.2 533.4 533.7 572.3 620.4 626.7 4265.6 4380.5 4405.9 4437.8 4500.6 100006.0 100158.5 102606.5 149478.0 157419.2 86207.0 89429.2 90202.0 112508.9 124919.4 80348.0 100493.5 100737.0 109991.0 112570.4 9227.9 9504.4 9677.7 9683.4 9777.9 49830.8 54051.7 60259.8 61917.7 62012.0 79976.0 84714.9 94617.5 96539.5 97940.0 12748.2 12973.9 13080.6 13088.8 13395.5 14511.1 14664.9 14703.7 14928.0 15138.0 13299.9 13764.4 13913.7 13915.8 14075.8 10822.6 13720.9 13730.7 13868.1 13873.9 10076.4 12636.9 12841.0 13312.7 13331.7 11056.9 11180.4 11466.4 11504.8 11654.4 8365.8 10000.9 10149.1 10180.1 11543.1 04:12:14 INFO - PROCESS | 1962 | -------- Summary: end -------- 04:12:14 INFO - PROCESS | 1962 | 04:12:15 INFO - TEST-INFO | 1962: exit 0 04:12:15 INFO - TEST-OK | dromaeo_css | took 1117707ms 04:12:15 INFO - TEST-START | kraken 04:12:15 INFO - operating with platform_type : mac_ 04:12:15 INFO - Initialising browser for kraken test... 04:12:15 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpr2Ef6_/profile http://localhost:50897/getInfo.html) 04:12:17 INFO - PROCESS | 1966 | __metrics Screen width/height:1600/1200 04:12:17 INFO - PROCESS | 1966 | colorDepth:24 04:12:17 INFO - PROCESS | 1966 | Browser inner width/height: 1024/689 04:12:17 INFO - PROCESS | 1966 | __metrics 04:12:17 INFO - PROCESS | 1966 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:12:17 INFO - PROCESS | 1966 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:12:18 INFO - TEST-INFO | 1966: exit 0 04:12:18 INFO - Browser initialized. 04:12:18 INFO - Running cycle 1/1 for kraken test... 04:12:18 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpr2Ef6_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:30 INFO - PROCESS | 1967 | RSS: Main: 234455040 04:12:30 INFO - PROCESS | 1967 | 04:12:33 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50897/tests/kraken/driver.html?testName=audio-beat-detection) 04:12:33 INFO - PROCESS | 1967 | RSS: Main: 293498880 04:12:33 INFO - PROCESS | 1967 | 04:12:36 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50897/tests/kraken/driver.html?testName=audio-dft) 04:12:37 INFO - PROCESS | 1967 | RSS: Main: 293269504 04:12:37 INFO - PROCESS | 1967 | 04:12:40 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50897/tests/kraken/driver.html?testName=audio-fft) 04:12:41 INFO - PROCESS | 1967 | RSS: Main: 382652416 04:12:41 INFO - PROCESS | 1967 | 04:12:43 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50897/tests/kraken/driver.html?testName=audio-oscillator) 04:12:43 INFO - PROCESS | 1967 | RSS: Main: 285073408 04:12:43 INFO - PROCESS | 1967 | 04:12:45 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50897/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:12:46 INFO - PROCESS | 1967 | RSS: Main: 289239040 04:12:46 INFO - PROCESS | 1967 | 04:12:49 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50897/tests/kraken/driver.html?testName=imaging-darkroom) 04:12:50 INFO - PROCESS | 1967 | RSS: Main: 325623808 04:12:50 INFO - PROCESS | 1967 | 04:12:53 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50897/tests/kraken/driver.html?testName=imaging-desaturate) 04:12:53 INFO - PROCESS | 1967 | RSS: Main: 327938048 04:12:53 INFO - PROCESS | 1967 | 04:12:56 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50897/tests/kraken/driver.html?testName=json-parse-financial) 04:12:57 INFO - PROCESS | 1967 | RSS: Main: 327168000 04:12:57 INFO - PROCESS | 1967 | 04:12:58 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50897/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:59 INFO - PROCESS | 1967 | RSS: Main: 300711936 04:12:59 INFO - PROCESS | 1967 | 04:13:01 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50897/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:13:01 INFO - PROCESS | 1967 | RSS: Main: 305111040 04:13:01 INFO - PROCESS | 1967 | 04:13:04 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50897/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:13:04 INFO - PROCESS | 1967 | RSS: Main: 307621888 04:13:04 INFO - PROCESS | 1967 | 04:13:07 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50897/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:13:08 INFO - PROCESS | 1967 | RSS: Main: 319397888 04:13:08 INFO - PROCESS | 1967 | 04:13:11 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50897/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:13:12 INFO - PROCESS | 1967 | RSS: Main: 319000576 04:13:12 INFO - PROCESS | 1967 | 04:13:13 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:50897/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50897/tests/kraken/driver.html?testName=ai-astar) 04:13:14 INFO - PROCESS | 1967 | RSS: Main: 362967040 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | __start_tp_report 04:13:14 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 04:13:14 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 04:13:14 INFO - PROCESS | 1967 | |i|pagename|runs| 04:13:14 INFO - PROCESS | 1967 | |0;ai-astar;113;113;114;113;113;113;114;122;115;114 04:13:14 INFO - PROCESS | 1967 | |1;audio-beat-detection;151;113;113;155;142;146;135;114;140;135 04:13:14 INFO - PROCESS | 1967 | |2;audio-dft;183;181;184;184;184;183;183;182;182;182 04:13:14 INFO - PROCESS | 1967 | |3;audio-fft;79;59;58;88;63;59;56;58;80;59 04:13:14 INFO - PROCESS | 1967 | |4;audio-oscillator;93;70;90;71;69;69;91;67;68;90 04:13:14 INFO - PROCESS | 1967 | |5;imaging-gaussian-blur;86;83;89;130;85;84;86;84;134;85 04:13:14 INFO - PROCESS | 1967 | |6;imaging-darkroom;96;95;117;166;166;96;96;96;96;95 04:13:14 INFO - PROCESS | 1967 | |7;imaging-desaturate;96;133;117;87;96;134;85;85;84;85 04:13:14 INFO - PROCESS | 1967 | |8;json-parse-financial;56;55;54;52;52;53;54;52;52;51 04:13:14 INFO - PROCESS | 1967 | |9;json-stringify-tinderbox;63;70;68;75;73;71;71;71;71;71 04:13:14 INFO - PROCESS | 1967 | |10;stanford-crypto-aes;88;87;87;88;86;86;89;84;98;108 04:13:14 INFO - PROCESS | 1967 | |11;stanford-crypto-ccm;149;146;145;146;142;153;130;151;212;145 04:13:14 INFO - PROCESS | 1967 | |12;stanford-crypto-pbkdf2;172;172;172;170;170;175;171;170;185;237 04:13:14 INFO - PROCESS | 1967 | |13;stanford-crypto-sha256-iterative;69;69;70;67;68;70;79;88;86;71 04:13:14 INFO - PROCESS | 1967 | __end_tp_report 04:13:14 INFO - PROCESS | 1967 | __start_cc_report 04:13:14 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,1923 04:13:14 INFO - PROCESS | 1967 | __end_cc_report 04:13:14 INFO - PROCESS | 1967 | __startTimestamp1476097994159__endTimestamp 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | ------- Summary: start ------- 04:13:14 INFO - PROCESS | 1967 | Number of tests: 14 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:2.76 (2.4%) stddev-sans-first:2.88 04:13:14 INFO - PROCESS | 1967 | Values: 113.0 113.0 114.0 113.0 113.0 113.0 114.0 122.0 115.0 114.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:141.00 stddev:15.83 (11.2%) stddev-sans-first:15.61 04:13:14 INFO - PROCESS | 1967 | Values: 151.0 113.0 113.0 155.0 142.0 146.0 135.0 114.0 140.0 135.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 04:13:14 INFO - PROCESS | 1967 | Values: 183.0 181.0 184.0 184.0 184.0 183.0 183.0 182.0 182.0 182.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#3] audio-fft Cycles:10 Average:65.90 Median:61.00 stddev:11.70 (19.2%) stddev-sans-first:11.41 04:13:14 INFO - PROCESS | 1967 | Values: 79.0 59.0 58.0 88.0 63.0 59.0 56.0 58.0 80.0 59.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:80.50 stddev:11.44 (14.2%) stddev-sans-first:10.73 04:13:14 INFO - PROCESS | 1967 | Values: 93.0 70.0 90.0 71.0 69.0 69.0 91.0 67.0 68.0 90.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:85.00 stddev:19.80 (23.3%) stddev-sans-first:20.76 04:13:14 INFO - PROCESS | 1967 | Values: 86.0 83.0 89.0 130.0 85.0 84.0 86.0 84.0 134.0 85.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#6] imaging-darkroom Cycles:10 Average:111.90 Median:96.00 stddev:29.28 (30.5%) stddev-sans-first:30.48 04:13:14 INFO - PROCESS | 1967 | Values: 96.0 95.0 117.0 166.0 166.0 96.0 96.0 96.0 96.0 95.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#7] imaging-desaturate Cycles:10 Average:100.20 Median:85.00 stddev:20.18 (23.7%) stddev-sans-first:21.35 04:13:14 INFO - PROCESS | 1967 | Values: 96.0 133.0 117.0 87.0 96.0 134.0 85.0 85.0 84.0 85.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.50 stddev:1.60 (3.0%) stddev-sans-first:1.30 04:13:14 INFO - PROCESS | 1967 | Values: 56.0 55.0 54.0 52.0 52.0 53.0 54.0 52.0 52.0 51.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:3.17 (4.5%) stddev-sans-first:1.92 04:13:14 INFO - PROCESS | 1967 | Values: 63.0 70.0 68.0 75.0 73.0 71.0 71.0 71.0 71.0 71.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:87.50 stddev:7.32 (8.4%) stddev-sans-first:7.73 04:13:14 INFO - PROCESS | 1967 | Values: 88.0 87.0 87.0 88.0 86.0 86.0 89.0 84.0 98.0 108.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:147.50 stddev:22.02 (14.9%) stddev-sans-first:23.33 04:13:14 INFO - PROCESS | 1967 | Values: 149.0 146.0 145.0 146.0 142.0 153.0 130.0 151.0 212.0 145.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:172.00 stddev:20.73 (12.1%) stddev-sans-first:21.82 04:13:14 INFO - PROCESS | 1967 | Values: 172.0 172.0 172.0 170.0 170.0 175.0 171.0 170.0 185.0 237.0 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - PROCESS | 1967 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:70.50 stddev:7.75 (11.0%) stddev-sans-first:8.03 04:13:14 INFO - PROCESS | 1967 | Values: 69.0 69.0 70.0 67.0 68.0 70.0 79.0 88.0 86.0 71.0 04:13:14 INFO - PROCESS | 1967 | -------- Summary: end -------- 04:13:14 INFO - PROCESS | 1967 | 04:13:14 INFO - TEST-INFO | 1967: exit 0 04:13:15 INFO - TEST-OK | kraken | took 59856ms 04:13:15 INFO - SUITE-END | took 1177s 04:13:15 INFO - Completed test suite (00:19:37) 04:13:15 INFO - javascript benchmark 04:13:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3263.4125857345675, 3284.9507257391138, 3317.0878008547647, 3341.64663311359, 3360.3279344131165, 5520.585956053292, 5603.187537807015, 5638.605297629168, 5678.034734095203, 5682.346530149034, 5636.7181640918, 5649.915251271234, 5733.0, 5737.856553586152, 5759.366469688342, 5065.214891691794, 5115.769790359443, 5120.897582048376, 5170.457102004292, 5183.015227106856, 5263.657862238962, 5281.524662780349, 5288.762005709733, 5305.602079844008, 5311.070562651521, 5259.263703081571, 5270.39390470097, 5298.788048478056, 5308.920366194491, 5354.544863686591, 4314.61168494837, 5106.540411362995, 5148.021875843578, 5169.0, 5170.870728231786, 5146.150885103953, 5149.356330458692, 5160.329157209576, 5178.533931946143, 5219.399769026534, 4886.682365646222, 5578.023845826964, 5707.6575405475805, 5715.504371934344, 5737.598368114233, 6073.058675905242, 6115.788007244199, 6142.017277235621, 6226.159468471744, 6232.781852635136, 6179.969100154515, 6181.072839074175, 6228.470580000705, 6242.843928901769, 6267.341929097424, 5753.654780713171, 5767.36558978512, 5778.248827652463, 5796.927568399901, 5818.505427038707, 6099.491378240913, 6143.170671959318, 6171.56799024064, 6208.50331973441, 6219.471344935731, 5494.780208791683, 5920.993431116721, 6109.101029780167, 6126.479249263863, 6138.202033735586, 6177.660228687465, 6179.876402471926, 6181.041938499539, 6194.721237544321, 6198.659073750897, 6015.969920150371, 6036.366181550961, 6193.969030154821, 6197.1324014637985, 6197.876042479125, 6109.266887973472, 6125.142480052797, 6161.876762464725, 6170.629762214281, 6192.81421557354, 4947.134251505972, 4951.257311403247, 4956.628252881048, 4971.477994810565, 4993.076280888047, 4418.5802348776815, 4440.955590444119, 4462.107578484316, 4473.396091527602, 4477.3731677565165, 4733.408323959505, 5574.721263936787, 5614.943850561442, 5665.518430933417, 5687.0, 6245.718942647592, 6264.498840092781, 6275.843103922347, 6279.654618995908, 6282.994720844643, 5398.541124004425, 5712.857178570486, 5715.799947001919, 5726.341470730836, 5727.684977326204, 5245.580353571705, 5291.153415453509, 5330.893382132335, 5397.298351214396, 5398.406175320712, 6175.505959523317, 6224.688765561613, 6234.75060997555, 6260.092286618324, 6264.686765661608, 5273.815416460406, 6255.155554000152, 6276.780312689034, 6283.088952102011, 6285.685715714288, 6145.907811382744, 6204.5967012144065, 6205.47253483459, 6241.719122639583, 6249.218847644044, 4933.629977751755, 6062.575619706578, 6086.02623580225, 6125.23545181825, 6144.433169541917, 5730.799422020209, 5908.670549126412, 6146.262448506208, 6206.906896396467, 6251.437370636664, 6077.331493535796, 6093.0, 6108.11432342299, 6122.877542449037, 6131.448169664752, 5921.3190483094995, 5985.521158307412, 5997.760089596367, 6086.3305036446845, 6113.02191649334, 5839.883202336015, 5884.911726324194, 5903.498202652822, 5915.290165180206, 5916.881662366643, 6016.42843929826, 6022.638641681513, 6030.095485677183, 6046.062860256668, 6053.303870055, 5863.970680146572, 5872.794452194153, 5879.970600146972, 5883.058710606282, 5892.381299963442], "value": 5635.713645826925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.45776153093215, 510.8084468324378, 534.794104269856, 539.2235181338872, 547.7097138516585, 41074.58925410745, 42381.0, 42614.147717045715, 42651.14697706044, 43558.34662480057, 42764.572354276446, 43143.568564314344, 43195.568044319545, 43212.3518147228, 43316.318112960354, 8857.468551886908, 9094.63621455141, 9789.951050244757, 9975.551100200471, 9987.650432234874, 11999.52001919922, 12308.446119924625, 12367.876321236807, 12375.690607734789, 12507.687307817287, 12272.447739851728, 12332.93833530831, 12343.19769214998, 12354.135210535265, 12374.071944604191, 8935.776605584848, 9144.0, 12085.214461060003, 12199.14605977582, 12236.204646697935, 11873.0, 11974.34141122238, 12056.156069075168, 12079.758404831942, 12088.09339299556, 39085.41371879424, 39348.40977385342, 39391.60608393937, 39409.0, 39479.40780888289, 3255.300110476259, 3273.508973653947, 3289.342131573671, 3334.7999120052873, 3373.561437013197, 25295.747042529707, 30547.541786873215, 31013.689863101306, 31779.52330715041, 31918.20204494883, 3304.7025767680784, 3312.3044160726276, 3361.445361515347, 3412.215190506173, 3425.7773244739014, 458670.3728515272, 459167.0, 459391.0, 462019.0, 462626.0, 59515.51211219667, 59861.70069149626, 59913.700431497564, 59945.70027149836, 60111.0, 63530.0, 63620.68189659022, 63665.36334636687, 63669.68165159145, 63680.68159659172, 15866.175389830318, 16084.517464476085, 16088.597785055466, 16101.75847362267, 16108.436204732778, 11172.664820055412, 11389.715257118638, 11402.657920262405, 12188.390580470941, 12286.324252166038, 16821.158942052847, 16889.915550422415, 16991.150442477825, 16992.150392480573, 16996.235169417407, 6286.876195900327, 6408.750293692685, 6726.932730672728, 6797.966010169917, 6889.622075584903, 881.850085485469, 938.3384713776771, 968.4770224079059, 981.4297124600724, 1004.1665417703289, 28815.0, 29845.10464686063, 29917.0, 30497.0, 30631.846840765655, 842.751388340441, 921.2629896083107, 1042.598599539183, 1064.2709743825503, 1089.8692156941058, 15090.698186036218, 15513.534593962198, 15647.452339168074, 15819.762703559456, 15916.840831591768, 567306.0, 571624.0, 574457.0, 576612.0, 577972.0, 56359.71820140873, 56396.0, 56426.0, 56477.870442590916, 56660.0, 1292.6768307923019, 1352.3441131051432, 1355.708522667631, 1358.1986627889592, 1360.53741727813, 29483.0, 29519.26201844971, 29708.0, 30451.543226851172, 30475.390492190476, 55268.44731552633, 56121.71939140278, 56188.43811561832, 58290.417095828496, 58375.0, 592305.0, 598120.0, 598756.0, 598831.0, 599426.0, 26075.608865867405, 26430.603540946515, 26518.469630607666, 26572.7342726578, 26580.0, 35683.0, 38750.2974537956, 44419.33370999502, 46960.0, 49585.75207124086, 31513.0, 38235.42646860244, 38687.03282417962, 38717.03207419725, 39325.0, 38592.42111368388, 38710.80644596759, 39690.0, 39757.60242397655, 40024.799876000434, 37364.813175933945, 38077.0, 38119.618803812715, 38397.6160238394, 38614.0, 33283.66716332806, 34079.82960085184, 34889.302213955074, 34946.65053349434, 35050.9484715459, 25368.98524059017, 25395.87302063478, 25485.0, 25960.350991225372, 26010.73989260159], "value": 20189.67714214728, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.23909757180564, 352.8747294710376, 365.3679135096282, 374.8463130116652, 383.1627893053679, 15041.699166016686, 15291.311890964906, 15854.84145158548, 20337.59324813503, 20863.582728345424, 20037.0, 20357.694634580494, 20744.792552074476, 20974.685379719318, 21064.157433702672, 5671.914921276184, 5769.221155144054, 6057.787977420791, 6068.059450785136, 6069.271687397519, 5032.396112466509, 5404.432534583871, 5982.670953097578, 5990.430909063632, 6010.519158467312, 5780.653160810344, 5780.884382312352, 5862.836795723134, 5914.497267732248, 5936.3173235077875, 5774.2782152230975, 5897.292324921015, 5902.1146827976145, 5904.439078287577, 5905.940940590582, 4675.760923355314, 4734.786934587917, 5142.562882155022, 5150.948490515084, 5185.533302002837, 25129.371765706004, 25587.0, 25619.743802561923, 25641.974321027137, 25934.481310373685, 2181.182056728727, 2308.0306271366067, 2325.9534809303887, 2353.446939969106, 2953.1731115287753, 15668.529944101696, 15773.763393549107, 16051.357945682159, 16114.355425782955, 16180.514584562481, 1574.645704716441, 1752.8860624059523, 1785.9821401786076, 1843.4930394141584, 1862.1992543206416, 84539.32361400353, 93001.53499232461, 109569.0, 109598.0, 110579.44710276397, 10383.63657272007, 10748.516316765608, 10821.67534973952, 10946.0, 11071.335719856674, 13419.463221471031, 13436.328183590782, 13445.260510672008, 13458.192508449525, 13473.663158421117, 8310.418270721113, 8446.915530844735, 8459.450135741157, 8476.194761497647, 8656.61045252965, 8402.747917562483, 8413.284870785928, 8444.394117675965, 8586.613602387908, 8594.097619749962, 5973.522118230531, 6043.697815109227, 6588.374104460068, 6605.0, 6633.777684475658, 1578.3923189572097, 1827.1321122466989, 1858.9070546472622, 1859.748933893934, 1862.07827125571, 862.6549380247951, 866.1554983890657, 892.2326798952895, 946.758576562972, 998.3560603410759, 20085.49358798067, 20920.79079209219, 21417.46456338573, 22281.55436891253, 22364.329070127922, 883.5935469683889, 904.2901322461836, 967.9516024198762, 969.413504829582, 974.9025097490194, 9480.525973701288, 11070.169737269576, 11806.17356785034, 11831.349275789915, 11921.88078119225, 551789.0, 561042.0, 567468.0, 575911.0, 578459.0, 73436.53126937432, 86608.56695716607, 95743.12770616893, 110616.4469177665, 115672.48128871765, 932.4125800745622, 959.4339339789558, 1013.1641395848454, 1014.523174108168, 1015.279151802214, 19660.410187694393, 19945.301914432926, 19969.25518198914, 20113.094910729345, 20120.698189527462, 47851.76074119607, 48921.510784891696, 49671.0, 50467.73830654263, 51422.22866657078, 69277.30722692709, 69644.60710785857, 71930.0, 72186.27813722006, 76252.23747762451, 6614.801555953329, 7740.961295193488, 7951.642176101974, 8071.717489887826, 8084.191580842104, 11446.542138314375, 12563.811542826683, 12821.743565128458, 13011.0, 13289.534866279633, 10981.780364392827, 11098.778024439627, 11172.553097875994, 11477.598284060017, 11528.962393384636, 10830.296030757976, 11038.558457661604, 11192.656881174311, 11270.549178032787, 11459.140564457532, 11108.833367499656, 11271.125862904906, 11414.885851141382, 11461.541538338373, 11517.308961462339, 7785.0, 8009.959950200212, 8071.959640201761, 8258.958705206436, 8307.792305192419, 10293.691189264335, 11032.834507482234, 11185.0, 11257.831132532854, 11295.943520282675], "value": 9500.515397903211, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.14911053368, 1524.5578782153177, 1719.509939667195, 1891.6216756648673, 1905.2664724081233, 8295.585220738962, 8795.780105497366, 8813.867791983126, 8817.985931617857, 8856.0, 6580.835479113024, 7759.612019399022, 8041.075276343222, 8621.439606425578, 8638.611262493187, 2297.2074634251157, 2327.208749025331, 2330.498942727313, 2332.3586013846243, 2335.065973610561, 2270.0919632147106, 2295.850769699964, 2298.643710224918, 2299.12633199384, 2313.4332088638307, 2313.53729254149, 2330.2543186180346, 2345.9765402346015, 2346.0, 2350.0, 2046.7441569803775, 2196.6929676842256, 2302.4243939015246, 2305.0779688124717, 2314.0743702518957, 2296.666983287414, 2298.597745394566, 2299.6320588705726, 2301.3786277704926, 2305.227748704186, 8677.479351238946, 8736.170063843989, 8785.428947118417, 8788.60451279694, 8811.206991370807, 5173.068847607429, 5333.253344531769, 5342.1452567589, 5349.866253343658, 5350.250964864922, 3411.181316484051, 3486.9476957845654, 3617.385044542434, 3633.5639723233116, 3636.5817930938015, 1021.7037059252808, 1054.2146101154613, 1060.3531845574194, 1076.784643071381, 1079.4818487126145, 11364.715882103013, 11446.885531144666, 11463.656090317303, 11470.713232169095, 11472.196946213768, 3707.4253490708443, 4049.311617025113, 4502.527234640381, 4644.722701257181, 4672.042231342567, 9817.901820981842, 9823.754406139904, 9824.164945979672, 9827.4103553787, 9859.014098590083, 5249.501297376743, 5311.176767601028, 5312.335958005249, 5326.201069839555, 5340.385855626652, 3869.5743468218475, 4382.956170438319, 4466.9106617867465, 4559.680822342404, 4895.31465594817, 3760.21743909505, 3786.5456145262747, 3916.177602703407, 3938.212357528506, 3949.7037722170953, 1248.431963456625, 1270.142653708743, 1273.4587800184884, 1282.1217466035796, 1282.2626989481087, 825.2984962781708, 890.496869268861, 899.470899470902, 912.885889263842, 949.8981181829046, 5484.314460692413, 5786.537077033827, 5833.125031245262, 5876.500497457679, 5927.081302398135, 432.7446806384248, 444.5532240098745, 446.85030514777264, 450.4189595421869, 451.98418055367904, 3346.8995930122137, 3418.9145271367915, 3920.3727403615285, 3935.8622448214173, 4054.1486287879284, 10284.28010039305, 10548.525316360781, 10688.144948404264, 10689.412082335546, 10690.786184276427, 10203.438810865473, 10389.896101038892, 10594.576216951236, 10602.992715691997, 10616.203784716177, 7922.405819563441, 8006.3995200360205, 8022.318102961197, 8110.716124935599, 8113.959430202811, 5565.944340556704, 5652.971735141298, 5700.429957004267, 5764.827055188351, 5882.911566394039, 9588.041195880356, 9794.804103918024, 9859.01409859037, 9892.85160722604, 9915.752106197402, 8918.420302680304, 10105.646302379382, 10113.89886101159, 10114.29199955996, 10116.342437741818, 6749.3250674932115, 7019.824504387431, 7397.926020739939, 7470.477066605503, 7514.361279291322, 7731.690732370867, 7933.523988560705, 8077.03075630928, 8238.794030149054, 8335.124811894664, 7264.164621068645, 7377.8524429510035, 7402.111746590228, 7477.588732619758, 7539.208383119693, 7266.709331626887, 7273.127224732854, 7278.526895751759, 7313.817154571178, 7361.30067643573, 6592.044153597797, 6624.370684784938, 6710.530262881747, 6713.261541230363, 6726.226483954408, 4782.593479554277, 4847.563719265283, 4854.466008738966, 4927.827526036572, 5002.874928126826, 4594.196015697306, 4885.65800393969, 4950.727709975986, 4976.776045077908, 5036.471170527042], "value": 4409.64523317378, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.8686871211023, 304.1210900497561, 311.0745532042174, 316.8304956848087, 319.5558174137947, 4883.780229889655, 5181.93218323616, 5316.813911513098, 5335.772772262382, 5363.383210930744, 4194.916101677964, 4409.184300904327, 4945.208766597336, 5094.0, 5299.8410047698635, 3228.8547015384247, 3849.749766265184, 3950.7629542227414, 3954.5056867891512, 3958.9802050989706, 3109.891153809617, 3394.456886898097, 4004.3982407037274, 4006.1987602479476, 4087.05997620546, 3717.070732316921, 3939.428782826503, 3959.1685745993377, 3963.8810835674976, 3973.7019723520707, 3281.1305004173673, 3966.690991972642, 3980.6417422431973, 3983.820728067215, 4010.63904248619, 2856.985715071432, 3419.316136772655, 3432.3821712091813, 3434.1242983039415, 3440.7935523868646, 5053.0, 5063.772130254148, 5112.948870511284, 5118.769655365518, 5148.665336753099, 4175.498940127174, 4379.474463064453, 4481.2381895077915, 4528.5245049270015, 4552.863414097583, 4543.273076307808, 4767.927216376288, 5007.799688012475, 5507.476789704971, 5543.143047079193, 3194.0, 3233.6604656510963, 3751.606081361445, 3760.4547340635454, 3785.318642644323, 5642.746076426571, 5686.891056244075, 5764.682942438206, 5802.854928626776, 5803.738831752581, 3207.4226639205167, 3344.8996530104137, 3352.8994130176134, 3808.7811900191673, 3817.3892177251505, 3866.7679939203736, 3867.5358956925347, 3877.7479463835325, 3898.3762597984187, 3900.804959752001, 3737.3459644562095, 4540.977295113504, 4547.613452856478, 4551.340055691906, 4566.406367172246, 5166.535011848951, 5516.0, 5526.47498487643, 5533.0, 5591.776328946878, 1306.6537367597593, 1323.4706117553055, 1329.3419757220238, 1329.6875234319928, 1330.6673331667084, 825.1789469477787, 850.910654381281, 862.6678728689375, 898.7573355194061, 906.1029580715044, 5184.7407629618365, 5226.863881671043, 5235.712035837989, 5261.500157485033, 5295.338082739658, 4378.912421751611, 4965.627577931669, 5648.237487939158, 5660.8867822643315, 5855.355910849803, 4901.456041346964, 5074.619403544749, 5174.97412512935, 5182.792688292426, 5236.622378565804, 2489.875506224718, 2688.448867982059, 2764.847933363684, 3003.5432815085105, 3020.7281344679086, 5586.860328491739, 5678.630888992202, 5858.681796595817, 5883.499902508334, 5946.702664866826, 4772.403449568804, 5738.5982981191755, 5809.838032393453, 5850.268716410449, 5876.853078673067, 5878.382769809194, 5899.911501327483, 5931.466168044896, 5943.227380440515, 5952.226210592682, 4793.496682848251, 4881.536254055859, 5163.709072731817, 5270.104082306094, 5671.319441667027, 5055.115354812967, 5142.562882154909, 5366.946330536644, 5411.512963833274, 5604.019296623156, 4941.65408421407, 5131.560545821441, 5175.948240517547, 5754.683492407958, 5798.623089499169, 3153.5585018097026, 3198.584184056058, 3636.618155093677, 3791.8104094795704, 3825.5983121771815, 4323.416338794348, 4936.901261974812, 5564.38791732901, 5588.898161520396, 5608.541779137372, 5510.972445137749, 5573.219749235192, 5581.609287349846, 5585.553155747449, 5587.525060369914, 5149.9742501287255, 5472.482657977375, 5483.561315094863, 5514.531264842533, 5622.550195984393, 4279.529251782364, 4521.412216411845, 5393.784248630011, 5393.83818485446, 5433.347998240237, 5311.3891902431715, 5452.5365343946205, 5600.179941519104, 5647.209390685225, 5748.798792042426, 4805.495422980537, 5129.435762066244, 5463.972680136733, 5484.753186106715, 5532.5297349724115], "value": 3991.731309691378, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.303554034816, 719.6186021408652, 770.6031393832177, 814.8655471847145, 824.9010118785746, 15276.083434993894, 16107.83892161078, 16158.192090395463, 16172.757408638865, 16523.173841307947, 14538.709225815477, 14652.340644670989, 14654.48709295175, 14667.92666036671, 14683.0, 673.1484671890063, 695.9269276725947, 695.9838635592016, 842.4818736477054, 847.9491230526188, 866.9133086691344, 871.2898987325341, 878.9296856251517, 880.8590625499921, 882.5587206396801, 934.5747684803398, 936.1060187520901, 936.2369668720005, 936.3679516326487, 938.1228551304553, 926.157196950775, 927.0821886332483, 928.2944961829058, 928.7956649537091, 929.1498279074673, 534.8769782949944, 553.2033871225423, 665.72705190872, 684.1960696182016, 689.2556039477353, 15240.0, 15270.16014119223, 15281.770773438408, 15289.6177595561, 15311.157886316249, 12672.493100275979, 13664.316784160752, 13849.099808512516, 14117.505887293895, 14142.292885355691, 12473.75052498954, 12527.74944501114, 12705.237685738884, 12734.80897786534, 13294.86705132946, 4545.886352841172, 4602.861914142581, 4656.4877863434995, 4696.295555666643, 4708.246680531133, 103707.48146259296, 103748.48125759399, 103879.9224015523, 103978.48010759974, 104235.0, 10621.787564248672, 10717.124503212062, 11028.28316159447, 11159.776804464027, 11498.94250528742, 19370.515737106685, 20072.69527480738, 21509.784902151092, 21559.92200389974, 21569.892150539148, 7560.206178351194, 7579.962100189574, 7679.116901556393, 7722.11195712489, 7795.103563090203, 4126.793660316972, 4192.350185721218, 4260.318349064135, 4282.528921818597, 4365.519792822787, 3376.7805092668896, 3478.704310133616, 3490.528778614905, 3491.982540087334, 3493.5807703075793, 627.3350248736355, 629.5215636116584, 633.654658211276, 636.9808905732835, 655.0, 601.3385276196236, 603.9335673076046, 608.2002167150183, 618.9473894718909, 634.3719717479662, 8413.70552030676, 8733.257673097858, 8890.73327800167, 8982.416142950688, 9028.232600228923, 533.3919331961567, 533.6851257757942, 572.27892855003, 620.4354037825557, 626.674129452682, 4265.573442655772, 4380.452443444569, 4405.867823965286, 4437.755923424178, 4500.639948804088, 100006.0, 100158.49920750495, 102606.48696756469, 149478.0, 157419.21290393473, 86207.0, 89429.21141577132, 90202.0, 112508.87491124983, 124919.37540312241, 80348.0, 100493.49753251333, 100737.0, 109991.0, 112570.43714781538, 9227.907720922705, 9504.382215155993, 9677.661281855102, 9683.41899486033, 9777.902220977983, 49830.75084624554, 54051.72974135104, 60259.79480410455, 61917.66576339613, 62012.0, 79976.0, 84714.9171049739, 94617.52691236499, 96539.51730241584, 97940.0, 12748.235105893677, 12973.935130324666, 13080.607581772561, 13088.803667944798, 13395.464181433023, 14511.1293322401, 14664.853351466349, 14703.705925881637, 14928.02967807089, 15138.016028958082, 13299.933500332436, 13764.449422023006, 13913.721725565634, 13915.791263130859, 14075.788863167265, 10822.626961178807, 13720.86279137196, 13730.65673358174, 13868.098573592684, 13873.861261387257, 10076.445795481026, 12636.936815315865, 12841.0, 13312.667183320495, 13331.733365332446, 11056.889431105586, 11180.401553825866, 11466.369349685847, 11504.769904602028, 11654.417279136178, 8365.790855228668, 10000.949900260368, 10149.086582207638, 10180.098741394766, 11543.076553875502], "value": 7628.744207496332, "unit": "score"}], "name": "dromaeo_css", "value": 7249.622938369505, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0, 122.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 113.0, 113.0, 155.0, 142.0, 146.0, 135.0, 114.0, 140.0, 135.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 184.0, 184.0, 184.0, 183.0, 183.0, 182.0, 182.0, 182.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 88.0, 63.0, 59.0, 56.0, 58.0, 80.0, 59.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 90.0, 71.0, 69.0, 69.0, 91.0, 67.0, 68.0, 90.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 89.0, 130.0, 85.0, 84.0, 86.0, 84.0, 134.0, 85.0], "value": 94.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 117.0, 166.0, 166.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 111.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 133.0, 117.0, 87.0, 96.0, 134.0, 85.0, 85.0, 84.0, 85.0], "value": 100.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 52.0, 52.0, 53.0, 54.0, 52.0, 52.0, 51.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 68.0, 75.0, 73.0, 71.0, 71.0, 71.0, 71.0, 71.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 88.0, 86.0, 86.0, 89.0, 84.0, 98.0, 108.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 145.0, 146.0, 142.0, 153.0, 130.0, 151.0, 212.0, 145.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 172.0, 170.0, 170.0, 175.0, 171.0, 170.0, 185.0, 237.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 67.0, 68.0, 70.0, 79.0, 88.0, 86.0, 71.0], "value": 73.7, "unit": "score"}], "name": "kraken", "value": 1500.6000000000001, "alertThreshold": 2.0}]} 04:13:15 INFO - Return code: 0 04:13:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:13:15 INFO - # TBPL SUCCESS # 04:13:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:13:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:13:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:13:15 INFO - 2016-10-10 04:13:15.491 screenresolution[1971:16087] starting screenresolution argv=screenresolution get 04:13:15 INFO - 2016-10-10 04:13:15.494 screenresolution[1971:16087] Display 0: 1600x1200x32@60 04:13:15 INFO - 2016-10-10 04:13:15.500 screenresolution[1972:16090] starting screenresolution argv=screenresolution list 04:13:15 INFO - Available Modes on Display 0 04:13:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:13:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:13:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:13:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:13:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:13:15 INFO - Intel Iris: 04:13:15 INFO - Chipset Model: Intel Iris 04:13:15 INFO - Type: GPU 04:13:15 INFO - Bus: Built-In 04:13:15 INFO - VRAM (Dynamic, Max): 1536 MB 04:13:15 INFO - Vendor: Intel (0x8086) 04:13:15 INFO - Device ID: 0x0a2e 04:13:15 INFO - Revision ID: 0x0009 04:13:15 INFO - Displays: 04:13:15 INFO - Display: 04:13:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:13:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:13:15 INFO - Display Serial Number: 1600x1200 60 04:13:15 INFO - Main Display: Yes 04:13:15 INFO - Mirror: Off 04:13:15 INFO - Online: Yes 04:13:15 INFO - Rotation: Supported 04:13:15 INFO - Return code: 0 04:13:15 INFO - Running post-action listener: _resource_record_post_action 04:13:15 INFO - [mozharness: 2016-10-10 11:13:15.738969Z] Finished run-tests step (success) 04:13:15 INFO - Running post-run listener: _resource_record_post_run 04:13:15 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 847872; Write bytes: 705864192; Read time: 7; Write time: 1961 04:13:15 INFO - TinderboxPrint: CPU usage
53.6% 04:13:15 INFO - TinderboxPrint: I/O read bytes / time
847,872 / 7 04:13:15 INFO - TinderboxPrint: I/O write bytes / time
705,864,192 / 1,961 04:13:15 INFO - TinderboxPrint: CPU idle
2,251.7 (46.4%) 04:13:15 INFO - TinderboxPrint: CPU system
971.0 (20.0%) 04:13:15 INFO - TinderboxPrint: CPU user
1,627.0 (33.5%) 04:13:15 INFO - TinderboxPrint: Swap in / out
408,604,672 / 0 04:13:15 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 406176256; Write bytes: 400700928; Read time: 29928; Write time: 824 04:13:15 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 724992; Write bytes: 294243328; Read time: 5; Write time: 1102 04:13:16 INFO - Running post-run listener: _upload_blobber_files 04:13:16 INFO - Blob upload gear active. 04:13:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:13:16 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 04:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:13:16 INFO - (blobuploader) - INFO - Open directory for files ... 04:13:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:13:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:13:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:17 INFO - (blobuploader) - INFO - Done attempting. 04:13:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:13:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:13:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:18 INFO - (blobuploader) - INFO - Done attempting. 04:13:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:13:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:13:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:20 INFO - (blobuploader) - INFO - Done attempting. 04:13:20 INFO - (blobuploader) - INFO - Iteration through files over. 04:13:20 INFO - Return code: 0 04:13:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:13:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:13:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce6fbf57f34dae1aa2280ffdbefb9d7ecb3964e00988eaedc08af899875bd46c2d06c75f7bbf38aa44e3966f0d810a3df6e911ef6ff16c2e7512225245bceba0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a36f6325630f7b5ea67ed76e5db747e767ffcf96cae35678d0dbe187f09a2c5ad9756abfe0432c96f302c4afbe7a7359b00253b5b6363080faa5c7741441740d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6265653d4cf550c02a953a7bab1cdced2e26bacbf47a88ea3404f8323e0b1d4fb7068d21ad0c7d6c0e671bcabd15b33c76b8ee7d6b352ba8e003448357c52687"} 04:13:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:13:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:13:20 INFO - Contents: 04:13:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce6fbf57f34dae1aa2280ffdbefb9d7ecb3964e00988eaedc08af899875bd46c2d06c75f7bbf38aa44e3966f0d810a3df6e911ef6ff16c2e7512225245bceba0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a36f6325630f7b5ea67ed76e5db747e767ffcf96cae35678d0dbe187f09a2c5ad9756abfe0432c96f302c4afbe7a7359b00253b5b6363080faa5c7741441740d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6265653d4cf550c02a953a7bab1cdced2e26bacbf47a88ea3404f8323e0b1d4fb7068d21ad0c7d6c0e671bcabd15b33c76b8ee7d6b352ba8e003448357c52687"} 04:13:20 INFO - Running post-run listener: copy_logs_to_upload_dir 04:13:20 INFO - Copying logs to upload dir... 04:13:20 INFO - mkdir: /builds/slave/test/build/upload/logs 04:13:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.892514 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-10 04:13:20.853315) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 04:13:20.858340) ========= 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.qwz2WolpNv/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.klwNTMYKTD/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce6fbf57f34dae1aa2280ffdbefb9d7ecb3964e00988eaedc08af899875bd46c2d06c75f7bbf38aa44e3966f0d810a3df6e911ef6ff16c2e7512225245bceba0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a36f6325630f7b5ea67ed76e5db747e767ffcf96cae35678d0dbe187f09a2c5ad9756abfe0432c96f302c4afbe7a7359b00253b5b6363080faa5c7741441740d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6265653d4cf550c02a953a7bab1cdced2e26bacbf47a88ea3404f8323e0b1d4fb7068d21ad0c7d6c0e671bcabd15b33c76b8ee7d6b352ba8e003448357c52687"} build_url:https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/PztQt1kQTSys4SrdjbBifw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce6fbf57f34dae1aa2280ffdbefb9d7ecb3964e00988eaedc08af899875bd46c2d06c75f7bbf38aa44e3966f0d810a3df6e911ef6ff16c2e7512225245bceba0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a36f6325630f7b5ea67ed76e5db747e767ffcf96cae35678d0dbe187f09a2c5ad9756abfe0432c96f302c4afbe7a7359b00253b5b6363080faa5c7741441740d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6265653d4cf550c02a953a7bab1cdced2e26bacbf47a88ea3404f8323e0b1d4fb7068d21ad0c7d6c0e671bcabd15b33c76b8ee7d6b352ba8e003448357c52687"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 04:13:20.891440) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 04:13:20.891766) ========= 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.qwz2WolpNv/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.klwNTMYKTD/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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.005050 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 04:13:20.940878) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 04:13:20.941195) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 04:13:20.941507) ========= ========= Total master_lag: 0.74 =========