builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0137 starttime: 1487871064.53 results: success (0) buildid: 20170223073922 builduid: 44ea8284f84049aca6ad520b1346e0ce revision: 7808ea875b492d7582f33020d604afa971d4ba67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 09:31:04.527729) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 09:31:04.528210) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 09:31:04.528484) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 09:31:04.553269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:31:04.553661) ========= 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.PFYllRUKET/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.Jo052fTBG7/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-23 09:31:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 32.9M=0s 2017-02-23 09:31:04 (32.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.249618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:31:04.827177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:31:04.827528) ========= 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.PFYllRUKET/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.Jo052fTBG7/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.020748 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:31:04.876379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-23 09:31:04.876733) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7808ea875b492d7582f33020d604afa971d4ba67 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7808ea875b492d7582f33020d604afa971d4ba67 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PFYllRUKET/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.Jo052fTBG7/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-23 09:31:04,961 truncating revision to first 12 chars 2017-02-23 09:31:04,961 Setting DEBUG logging. 2017-02-23 09:31:04,961 attempt 1/10 2017-02-23 09:31:04,961 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7808ea875b49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 09:31:06,799 unpacking tar archive at: mozilla-aurora-7808ea875b49/testing/mozharness/ program finished with exit code 0 elapsedTime=2.120900 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-23 09:31:07.020928) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 09:31:07.021299) ========= script_repo_revision: 7808ea875b492d7582f33020d604afa971d4ba67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 09:31:07.021751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 09:31:07.022037) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 09:31:07.041379) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-23 09:31:07.041778) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PFYllRUKET/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.Jo052fTBG7/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 09:31:07 INFO - MultiFileLogger online at 20170223 09:31:07 in /builds/slave/test 09:31:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:31:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:31:07 INFO - {'append_to_log': False, 09:31:07 INFO - 'base_work_dir': '/builds/slave/test', 09:31:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:31:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:31:07 INFO - 'branch': 'Mozilla-Aurora', 09:31:07 INFO - 'buildbot_json_path': 'buildprops.json', 09:31:07 INFO - 'config_files': ('talos/mac_config.py',), 09:31:07 INFO - 'default_actions': ('clobber', 09:31:07 INFO - 'read-buildbot-config', 09:31:07 INFO - 'download-and-extract', 09:31:07 INFO - 'populate-webroot', 09:31:07 INFO - 'create-virtualenv', 09:31:07 INFO - 'install', 09:31:07 INFO - 'run-tests'), 09:31:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:31:07 INFO - 'download_minidump_stackwalk': True, 09:31:07 INFO - 'download_symbols': 'ondemand', 09:31:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:31:07 INFO - 'tooltool.py': '/tools/tooltool.py', 09:31:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:31:07 INFO - '/tools/misc-python/virtualenv.py')}, 09:31:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:31:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:31:07 INFO - 'installer_path': 'installer.exe', 09:31:07 INFO - 'log_level': 'info', 09:31:07 INFO - 'log_name': 'talos', 09:31:07 INFO - 'log_to_console': True, 09:31:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:31:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:31:07 INFO - 'opt_config_files': (), 09:31:07 INFO - 'pip_index': False, 09:31:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:31:07 INFO - 'cmd': ('bash', 09:31:07 INFO - '-c', 09:31:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:31:07 INFO - 'enabled': True, 09:31:07 INFO - 'halt_on_failure': False, 09:31:07 INFO - 'name': 'check_screen_resolution'},), 09:31:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:31:07 INFO - 'cmd': ('bash', 09:31:07 INFO - '-c', 09:31:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:31:07 INFO - 'enabled': True, 09:31:07 INFO - 'halt_on_failure': False, 09:31:07 INFO - 'name': 'check_screen_resolution'},), 09:31:07 INFO - 'run_cmd_checks_enabled': True, 09:31:07 INFO - 'sps_profile': False, 09:31:07 INFO - 'sps_profile_interval': 0, 09:31:07 INFO - 'suite': 'dromaeojs-e10s', 09:31:07 INFO - 'system_bits': '32', 09:31:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:31:07 INFO - 'title': 't-yosemite-r7-0137', 09:31:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:31:07 INFO - 'use_talos_json': True, 09:31:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:31:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:31:07 INFO - 'work_dir': 'build'} 09:31:07 INFO - [mozharness: 2017-02-23 17:31:07.252356Z] Running clobber step. 09:31:07 INFO - Running pre-action listener: _resource_record_pre_action 09:31:07 INFO - Running main action method: clobber 09:31:07 INFO - rmtree: /builds/slave/test/build 09:31:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:31:09 INFO - Running post-action listener: _resource_record_post_action 09:31:09 INFO - [mozharness: 2017-02-23 17:31:09.336420Z] Finished clobber step (success) 09:31:09 INFO - [mozharness: 2017-02-23 17:31:09.336625Z] Running read-buildbot-config step. 09:31:09 INFO - Running pre-action listener: _resource_record_pre_action 09:31:09 INFO - Running main action method: read_buildbot_config 09:31:09 INFO - Using buildbot properties: 09:31:09 INFO - { 09:31:09 INFO - "project": "", 09:31:09 INFO - "product": "firefox", 09:31:09 INFO - "script_repo_revision": "production", 09:31:09 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 09:31:09 INFO - "repository": "", 09:31:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 09:31:09 INFO - "buildid": "20170223073922", 09:31:09 INFO - "pgo_build": "False", 09:31:09 INFO - "basedir": "/builds/slave/test", 09:31:09 INFO - "buildnumber": 6, 09:31:09 INFO - "slavename": "t-yosemite-r7-0137", 09:31:09 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:31:09 INFO - "platform": "yosemite_r7", 09:31:09 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:31:09 INFO - "branch": "mozilla-aurora", 09:31:09 INFO - "repo_path": "releases/mozilla-aurora", 09:31:09 INFO - "revision": "7808ea875b492d7582f33020d604afa971d4ba67", 09:31:09 INFO - "stage_platform": "macosx64", 09:31:09 INFO - "builduid": "44ea8284f84049aca6ad520b1346e0ce", 09:31:09 INFO - "slavebuilddir": "test" 09:31:09 INFO - } 09:31:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:31:09 INFO - Running post-action listener: _resource_record_post_action 09:31:09 INFO - [mozharness: 2017-02-23 17:31:09.342333Z] Finished read-buildbot-config step (success) 09:31:09 INFO - [mozharness: 2017-02-23 17:31:09.342535Z] Running download-and-extract step. 09:31:09 INFO - Running pre-action listener: _resource_record_pre_action 09:31:09 INFO - Running main action method: download_and_extract 09:31:09 INFO - mkdir: /builds/slave/test/build/tests 09:31: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')]} 09:31:09 INFO - trying https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:31:09 INFO - Downloading https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:31:10 INFO - Downloaded 1199 bytes. 09:31:10 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:31:10 INFO - Using the following test package requirements: 09:31:10 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:31:10 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:31:10 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:31:10 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:31:10 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:31:10 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:31:10 INFO - u'jsshell-mac.zip'], 09:31:10 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:31:10 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:31:10 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:31:10 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:31:10 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:31:10 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:31:10 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:31:10 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:31:10 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:31:10 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:31:10 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:31:10 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:31:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:31:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:31:10 INFO - Fetch https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:31:11 INFO - Expected file size: 16357569 09:31:11 INFO - Obtained file size: 16357569 09:31:18 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:31:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:31:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:31:18 INFO - Fetch https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:31:18 INFO - Expected file size: 16357569 09:31:18 INFO - Obtained file size: 16357569 09:31:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:31:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:31:25 INFO - Fetch https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:31:26 INFO - Expected file size: 14403485 09:31:26 INFO - Obtained file size: 14403485 09:31:26 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')]} 09:31:26 INFO - trying https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:31:26 INFO - Downloading https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:31:29 INFO - Downloaded 73928827 bytes. 09:31:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:31:29 INFO - mkdir: /builds/slave/test/properties 09:31:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:31:29 INFO - Writing to file /builds/slave/test/properties/build_url 09:31:29 INFO - Contents: 09:31:29 INFO - build_url:https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:31:29 INFO - Running post-action listener: _resource_record_post_action 09:31:29 INFO - Running post-action listener: set_extra_try_arguments 09:31:29 INFO - [mozharness: 2017-02-23 17:31:29.761759Z] Finished download-and-extract step (success) 09:31:29 INFO - [mozharness: 2017-02-23 17:31:29.761923Z] Running populate-webroot step. 09:31:29 INFO - Running pre-action listener: _resource_record_pre_action 09:31:29 INFO - Running main action method: populate_webroot 09:31:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:31:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:31:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:31:29 INFO - '--tppagecycles', 09:31:29 INFO - '7'], 09:31:29 INFO - 'tests': ['tsvgm']}}, 09:31:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:31:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:31:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:31:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:31:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:31:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:31:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:31:29 INFO - 'talos_options': ['--disable-e10s'], 09:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:31:29 INFO - 'talos_options': ['--disable-e10s'], 09:31:29 INFO - 'tests': ['damp', 'tps']}, 09:31:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:31:29 INFO - 'tests': ['damp', 'tps']}, 09:31:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:31:29 INFO - 'tests': ['dromaeo_dom']}, 09:31:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:31:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:31:29 INFO - 'tests': ['basic_compositor_video']}, 09:31:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:31:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:31:29 INFO - 'tests': ['a11yr', 09:31:29 INFO - 'ts_paint', 09:31:29 INFO - 'tpaint', 09:31:29 INFO - 'sessionrestore', 09:31:29 INFO - 'sessionrestore_no_auto_restore', 09:31:29 INFO - 'tabpaint']}, 09:31:29 INFO - 'other-e10s': {'tests': ['a11yr', 09:31:29 INFO - 'ts_paint', 09:31:29 INFO - 'tpaint', 09:31:29 INFO - 'sessionrestore', 09:31:29 INFO - 'sessionrestore_no_auto_restore', 09:31:29 INFO - 'tabpaint']}, 09:31:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:31:29 INFO - 'ts_paint', 09:31:29 INFO - 'tpaint', 09:31:29 INFO - 'sessionrestore', 09:31:29 INFO - 'sessionrestore_no_auto_restore', 09:31:29 INFO - 'tabpaint']}, 09:31:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:31:29 INFO - 'ts_paint', 09:31:29 INFO - 'tpaint', 09:31:29 INFO - 'sessionrestore', 09:31:29 INFO - 'sessionrestore_no_auto_restore', 09:31:29 INFO - 'tabpaint']}, 09:31:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:31:29 INFO - 'tests': ['a11yr', 09:31:29 INFO - 'ts_paint', 09:31:29 INFO - 'tpaint', 09:31:29 INFO - 'sessionrestore', 09:31:29 INFO - 'sessionrestore_no_auto_restore', 09:31:29 INFO - 'tabpaint']}, 09:31:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:31:29 INFO - 'tests': ['a11yr', 09:31:29 INFO - 'ts_paint', 09:31:29 INFO - 'tpaint', 09:31:29 INFO - 'sessionrestore', 09:31:29 INFO - 'sessionrestore_no_auto_restore', 09:31:29 INFO - 'tabpaint']}, 09:31:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:31:29 INFO - 'tests': ['tsvgx', 09:31:29 INFO - 'tsvgr_opacity', 09:31:29 INFO - 'tart', 09:31:29 INFO - 'tscrollx', 09:31:29 INFO - 'cart', 09:31:29 INFO - 'tsvg_static']}, 09:31:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:31:29 INFO - 'tsvgr_opacity', 09:31:29 INFO - 'tart', 09:31:29 INFO - 'tscrollx', 09:31:29 INFO - 'cart', 09:31:29 INFO - 'tsvg_static']}, 09:31:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:31:29 INFO - 'talos_options': ['--disable-e10s'], 09:31:29 INFO - 'tests': ['tp5o']}, 09:31:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:31:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:31:29 INFO - 'talos_options': ['--disable-e10s', 09:31:29 INFO - '--xperf_path', 09:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:29 INFO - 'tests': ['tp5n']}, 09:31:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:31:29 INFO - 'talos_options': ['--xperf_path', 09:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:29 INFO - 'tests': ['tp5n']}}, 09:31:29 INFO - 'talos.zip': {'path': '', 09:31:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:31:29 INFO - Running post-action listener: _resource_record_post_action 09:31:29 INFO - [mozharness: 2017-02-23 17:31:29.780650Z] Finished populate-webroot step (success) 09:31:29 INFO - [mozharness: 2017-02-23 17:31:29.780758Z] Running create-virtualenv step. 09:31:29 INFO - Running pre-action listener: _resource_record_pre_action 09:31:29 INFO - Running main action method: create_virtualenv 09:31:29 INFO - Creating virtualenv /builds/slave/test/build/venv 09:31:29 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 09:31:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:31:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:31:29 INFO - Using real prefix '/tools/python27' 09:31:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:31:30 INFO - Installing distribute.............................................................................................................................................................................................done. 09:31:33 INFO - Installing pip.................done. 09:31:33 INFO - Return code: 0 09:31:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:31:33 INFO - Reading from file tmpfile_stdout 09:31:33 INFO - Output received: 09:31:33 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) 09:31:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102ff5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d2d791f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3d30>, '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 0x102cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dc8be8>, '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.PFYllRUKET/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.Jo052fTBG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 09:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:31:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PFYllRUKET/Render', 09:31:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:33 INFO - 'HOME': '/Users/cltbld', 09:31:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:33 INFO - 'LOGNAME': 'cltbld', 09:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:33 INFO - 'MOZ_NO_REMOTE': '1', 09:31:33 INFO - 'NO_EM_RESTART': '1', 09:31:33 INFO - 'PAGER': '/bin/cat', 09:31:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:33 INFO - 'PWD': '/builds/slave/test', 09:31:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:33 INFO - 'SHELL': '/bin/bash', 09:31:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jo052fTBG7/Listeners', 09:31:33 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:31:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:33 INFO - 'USER': 'cltbld', 09:31:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:33 INFO - 'XPC_FLAGS': '0x0', 09:31:33 INFO - 'XPC_SERVICE_NAME': '0', 09:31:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31: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 09:31:34 INFO - Cleaning up... 09:31:34 INFO - Return code: 0 09:31:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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 0x102ff5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d2d791f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3d30>, '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 0x102cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dc8be8>, '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.PFYllRUKET/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.Jo052fTBG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 09:31: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 09:31: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 09:31:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PFYllRUKET/Render', 09:31:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:34 INFO - 'HOME': '/Users/cltbld', 09:31:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:34 INFO - 'LOGNAME': 'cltbld', 09:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:34 INFO - 'MOZ_NO_REMOTE': '1', 09:31:34 INFO - 'NO_EM_RESTART': '1', 09:31:34 INFO - 'PAGER': '/bin/cat', 09:31:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:34 INFO - 'PWD': '/builds/slave/test', 09:31:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:34 INFO - 'SHELL': '/bin/bash', 09:31:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jo052fTBG7/Listeners', 09:31:34 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:31:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:34 INFO - 'USER': 'cltbld', 09:31:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:34 INFO - 'XPC_FLAGS': '0x0', 09:31:34 INFO - 'XPC_SERVICE_NAME': '0', 09:31:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:34 INFO - Downloading/unpacking psutil>=3.1.1 09:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:31:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:38 INFO - Installing collected packages: psutil 09:31:38 INFO - Running setup.py install for psutil 09:31:38 INFO - building 'psutil._psutil_osx' extension 09:31: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 09:31: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 09:31: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 09:31:38 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 09:31:38 INFO - building 'psutil._psutil_posix' extension 09:31:38 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 09:31:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:31:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:31:38 INFO - ^ 09:31:38 INFO - 1 warning generated. 09:31:38 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 09:31:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:38 INFO - Successfully installed psutil 09:31:38 INFO - Cleaning up... 09:31:38 INFO - Return code: 0 09:31:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102ff5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d2d791f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3d30>, '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 0x102cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dc8be8>, '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.PFYllRUKET/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.Jo052fTBG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 09:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:31:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PFYllRUKET/Render', 09:31:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:38 INFO - 'HOME': '/Users/cltbld', 09:31:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:38 INFO - 'LOGNAME': 'cltbld', 09:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:38 INFO - 'MOZ_NO_REMOTE': '1', 09:31:38 INFO - 'NO_EM_RESTART': '1', 09:31:38 INFO - 'PAGER': '/bin/cat', 09:31:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:38 INFO - 'PWD': '/builds/slave/test', 09:31:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:38 INFO - 'SHELL': '/bin/bash', 09:31:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jo052fTBG7/Listeners', 09:31:38 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:31:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:38 INFO - 'USER': 'cltbld', 09:31:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:38 INFO - 'XPC_FLAGS': '0x0', 09:31:38 INFO - 'XPC_SERVICE_NAME': '0', 09:31:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:31:42 INFO - Installing collected packages: mozsystemmonitor 09:31:42 INFO - Running setup.py install for mozsystemmonitor 09:31:42 INFO - Successfully installed mozsystemmonitor 09:31:42 INFO - Cleaning up... 09:31:42 INFO - Return code: 0 09:31:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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 0x102ff5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d2d791f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3d30>, '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 0x102cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dc8be8>, '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.PFYllRUKET/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.Jo052fTBG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 09:31: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 09:31: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 09:31:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PFYllRUKET/Render', 09:31:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:42 INFO - 'HOME': '/Users/cltbld', 09:31:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:42 INFO - 'LOGNAME': 'cltbld', 09:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:42 INFO - 'MOZ_NO_REMOTE': '1', 09:31:42 INFO - 'NO_EM_RESTART': '1', 09:31:42 INFO - 'PAGER': '/bin/cat', 09:31:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:42 INFO - 'PWD': '/builds/slave/test', 09:31:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:42 INFO - 'SHELL': '/bin/bash', 09:31:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jo052fTBG7/Listeners', 09:31:42 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:31:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:42 INFO - 'USER': 'cltbld', 09:31:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:42 INFO - 'XPC_FLAGS': '0x0', 09:31:42 INFO - 'XPC_SERVICE_NAME': '0', 09:31:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:42 INFO - Downloading/unpacking jsonschema==2.5.1 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:31:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:31:45 INFO - warning: no files found matching '*.txt' 09:31:45 INFO - no previously-included directories found matching 'build' 09:31:45 INFO - no previously-included directories found matching 'dist' 09:31:45 INFO - no previously-included directories found matching '.git*' 09:31:45 INFO - Installing collected packages: jsonschema, functools32 09:31:45 INFO - Running setup.py install for functools32 09:31:45 INFO - warning: no files found matching '*.txt' 09:31:45 INFO - no previously-included directories found matching 'build' 09:31:45 INFO - no previously-included directories found matching 'dist' 09:31:45 INFO - no previously-included directories found matching '.git*' 09:31:45 INFO - Successfully installed jsonschema functools32 09:31:45 INFO - Cleaning up... 09:31:45 INFO - Return code: 0 09:31:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:31:45 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')]} 09:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:45 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')]} 09:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:45 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 0x102ff5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d2d791f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3d30>, '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 0x102cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dc8be8>, '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.PFYllRUKET/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.Jo052fTBG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 09:31:45 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 09:31:45 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 09:31:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PFYllRUKET/Render', 09:31:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:45 INFO - 'HOME': '/Users/cltbld', 09:31:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:45 INFO - 'LOGNAME': 'cltbld', 09:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:45 INFO - 'MOZ_NO_REMOTE': '1', 09:31:45 INFO - 'NO_EM_RESTART': '1', 09:31:45 INFO - 'PAGER': '/bin/cat', 09:31:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:45 INFO - 'PWD': '/builds/slave/test', 09:31:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:45 INFO - 'SHELL': '/bin/bash', 09:31:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jo052fTBG7/Listeners', 09:31:45 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:31:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:45 INFO - 'USER': 'cltbld', 09:31:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:45 INFO - 'XPC_FLAGS': '0x0', 09:31:45 INFO - 'XPC_SERVICE_NAME': '0', 09:31:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:31:46 INFO - Cleaning up... 09:31:46 INFO - Return code: 0 09:31:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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 0x102ff5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d2d791f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3d30>, '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 0x102cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dc8be8>, '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.PFYllRUKET/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.Jo052fTBG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 09:31: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 09:31: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 09:31:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PFYllRUKET/Render', 09:31:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:46 INFO - 'HOME': '/Users/cltbld', 09:31:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:46 INFO - 'LOGNAME': 'cltbld', 09:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:46 INFO - 'MOZ_NO_REMOTE': '1', 09:31:46 INFO - 'NO_EM_RESTART': '1', 09:31:46 INFO - 'PAGER': '/bin/cat', 09:31:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:46 INFO - 'PWD': '/builds/slave/test', 09:31:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:46 INFO - 'SHELL': '/bin/bash', 09:31:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jo052fTBG7/Listeners', 09:31:46 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:31:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:46 INFO - 'USER': 'cltbld', 09:31:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:46 INFO - 'XPC_FLAGS': '0x0', 09:31:46 INFO - 'XPC_SERVICE_NAME': '0', 09:31:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:46 INFO - Downloading/unpacking blobuploader==1.2.4 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:49 INFO - Downloading blobuploader-1.2.4.tar.gz 09:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:31:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:31:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:50 INFO - Downloading docopt-0.6.1.tar.gz 09:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:31:50 INFO - Installing collected packages: blobuploader, requests, docopt 09:31:50 INFO - Running setup.py install for blobuploader 09:31:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:31:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:31:50 INFO - Running setup.py install for requests 09:31:51 INFO - Running setup.py install for docopt 09:31:51 INFO - Successfully installed blobuploader requests docopt 09:31:51 INFO - Cleaning up... 09:31:51 INFO - Return code: 0 09:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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 0x102ff5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d2d791f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3d30>, '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 0x102cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dc8be8>, '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.PFYllRUKET/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.Jo052fTBG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 09:31: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 09:31: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 09:31:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PFYllRUKET/Render', 09:31:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:51 INFO - 'HOME': '/Users/cltbld', 09:31:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:51 INFO - 'LOGNAME': 'cltbld', 09:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:51 INFO - 'MOZ_NO_REMOTE': '1', 09:31:51 INFO - 'NO_EM_RESTART': '1', 09:31:51 INFO - 'PAGER': '/bin/cat', 09:31:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:51 INFO - 'PWD': '/builds/slave/test', 09:31:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:51 INFO - 'SHELL': '/bin/bash', 09:31:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jo052fTBG7/Listeners', 09:31:51 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:31:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:51 INFO - 'USER': 'cltbld', 09:31:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:51 INFO - 'XPC_FLAGS': '0x0', 09:31:51 INFO - 'XPC_SERVICE_NAME': '0', 09:31:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:31:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-MEphki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:31:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-xPfuCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:31:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-5hUZQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:31:51 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-H3pvnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:31:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-WQ9rXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:31:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Ill4F6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:31:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Rnlquh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:31:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-tGmxyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:31:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-eSVzo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:31:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Khia3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:31:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-VjFwuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:31:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ZJAL0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:31:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-V1YIm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:31:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-s45Wib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-C6rwr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:31:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-xRszBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:31:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-J2bY86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:31:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:31:53 INFO - Running setup.py install for manifestparser 09:31:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:31:53 INFO - Running setup.py install for mozcrash 09:31:53 INFO - Running setup.py install for mozdebug 09:31:53 INFO - Running setup.py install for mozdevice 09:31:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:31:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:31:53 INFO - Running setup.py install for mozfile 09:31:54 INFO - Running setup.py install for mozhttpd 09:31:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:31:54 INFO - Running setup.py install for mozinfo 09:31:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:31:54 INFO - Running setup.py install for mozInstall 09:31:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:31:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:31:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:31:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:31:54 INFO - Running setup.py install for mozleak 09:31:54 INFO - Running setup.py install for mozlog 09:31:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:31:54 INFO - Running setup.py install for moznetwork 09:31:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:31:55 INFO - Running setup.py install for mozprocess 09:31:55 INFO - Running setup.py install for mozprofile 09:31:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:31:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:31:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:31:55 INFO - Running setup.py install for mozrunner 09:31:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:31:55 INFO - Running setup.py install for mozscreenshot 09:31:55 INFO - Running setup.py install for moztest 09:31:55 INFO - Running setup.py install for mozversion 09:31:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:31:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:31:55 INFO - Cleaning up... 09:31:55 INFO - Return code: 0 09:31:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31:55 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')]} 09:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:55 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')]} 09:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:55 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 0x102ff5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d2d791f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3d30>, '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 0x102cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dc8be8>, '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.PFYllRUKET/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.Jo052fTBG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 09:31:55 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 09:31:55 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 09:31:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PFYllRUKET/Render', 09:31:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:55 INFO - 'HOME': '/Users/cltbld', 09:31:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:55 INFO - 'LOGNAME': 'cltbld', 09:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:55 INFO - 'MOZ_NO_REMOTE': '1', 09:31:55 INFO - 'NO_EM_RESTART': '1', 09:31:55 INFO - 'PAGER': '/bin/cat', 09:31:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:55 INFO - 'PWD': '/builds/slave/test', 09:31:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:55 INFO - 'SHELL': '/bin/bash', 09:31:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jo052fTBG7/Listeners', 09:31:55 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:31:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:55 INFO - 'USER': 'cltbld', 09:31:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:55 INFO - 'XPC_FLAGS': '0x0', 09:31:55 INFO - 'XPC_SERVICE_NAME': '0', 09:31:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:31:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-MgRNwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:31: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)) 09:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:31:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-GLVFtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:31:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-G9fRAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:31: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)) 09:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:31:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Ov8_Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:31:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-4T3sp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:31: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)) 09:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:31:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-kDDr1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:31: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)) 09:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:31:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-tSUjuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:31:56 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)) 09:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:31:56 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-9cI6db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:31: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)) 09:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:31:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-YHskzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:31: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)) 09:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:31:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-abMTE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:31: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)) 09:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:31:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-R_MEcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:31: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)) 09:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:31:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ZLtLKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:31:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-pp59ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:31: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)) 09:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:31:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-UAeWDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-cd9YW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:31: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)) 09:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:31:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-tQmkn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:31:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-OLlViu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:31: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)) 09:31: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==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:31: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==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:31: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)) 09:31: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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:31: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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:31:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:32:00 INFO - Downloading blessings-1.6.tar.gz 09:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:32:00 INFO - Installing collected packages: blessings 09:32:00 INFO - Running setup.py install for blessings 09:32:00 INFO - Successfully installed blessings 09:32:00 INFO - Cleaning up... 09:32:00 INFO - Return code: 0 09:32:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:32:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:01 INFO - Reading from file tmpfile_stdout 09:32:01 INFO - Current package versions: 09:32:01 INFO - blessings == 1.6 09:32:01 INFO - blobuploader == 1.2.4 09:32:01 INFO - docopt == 0.6.1 09:32:01 INFO - functools32 == 3.2.3-2 09:32:01 INFO - jsonschema == 2.5.1 09:32:01 INFO - manifestparser == 1.1 09:32:01 INFO - mozInstall == 1.12 09:32:01 INFO - mozcrash == 1.0 09:32:01 INFO - mozdebug == 0.1 09:32:01 INFO - mozdevice == 0.49 09:32:01 INFO - mozfile == 1.2 09:32:01 INFO - mozhttpd == 0.7 09:32:01 INFO - mozinfo == 0.9 09:32:01 INFO - mozleak == 0.1 09:32:01 INFO - mozlog == 3.4 09:32:01 INFO - moznetwork == 0.27 09:32:01 INFO - mozprocess == 0.24 09:32:01 INFO - mozprofile == 0.28 09:32:01 INFO - mozrunner == 6.13 09:32:01 INFO - mozscreenshot == 0.1 09:32:01 INFO - mozsystemmonitor == 0.3 09:32:01 INFO - moztest == 0.8 09:32:01 INFO - mozversion == 1.4 09:32:01 INFO - psutil == 3.1.1 09:32:01 INFO - requests == 1.2.3 09:32:01 INFO - wsgiref == 0.1.2 09:32:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:02 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 0x102ff5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d2d791f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3d30>, '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 0x102cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dc8be8>, '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.PFYllRUKET/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.Jo052fTBG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 09:32:02 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 09:32:02 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 09:32:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PFYllRUKET/Render', 09:32:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:02 INFO - 'HOME': '/Users/cltbld', 09:32:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:02 INFO - 'LOGNAME': 'cltbld', 09:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:02 INFO - 'MOZ_NO_REMOTE': '1', 09:32:02 INFO - 'NO_EM_RESTART': '1', 09:32:02 INFO - 'PAGER': '/bin/cat', 09:32:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:02 INFO - 'PWD': '/builds/slave/test', 09:32:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:02 INFO - 'SHELL': '/bin/bash', 09:32:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jo052fTBG7/Listeners', 09:32:02 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:32:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:02 INFO - 'USER': 'cltbld', 09:32:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:02 INFO - 'XPC_FLAGS': '0x0', 09:32:02 INFO - 'XPC_SERVICE_NAME': '0', 09:32:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:02 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)) 09:32:02 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)) 09:32:02 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)) 09:32:02 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)) 09:32:02 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)) 09:32:02 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)) 09:32:02 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)) 09:32:02 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)) 09:32:02 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)) 09:32:02 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)) 09:32:02 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)) 09:32:02 INFO - Cleaning up... 09:32:02 INFO - Return code: 0 09:32:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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 0x102ff5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d2d791f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dd3d30>, '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 0x102cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dc8be8>, '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.PFYllRUKET/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.Jo052fTBG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 09:32: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 09:32: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 09:32:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PFYllRUKET/Render', 09:32:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:02 INFO - 'HOME': '/Users/cltbld', 09:32:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:02 INFO - 'LOGNAME': 'cltbld', 09:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:02 INFO - 'MOZ_NO_REMOTE': '1', 09:32:02 INFO - 'NO_EM_RESTART': '1', 09:32:02 INFO - 'PAGER': '/bin/cat', 09:32:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:02 INFO - 'PWD': '/builds/slave/test', 09:32:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:02 INFO - 'SHELL': '/bin/bash', 09:32:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jo052fTBG7/Listeners', 09:32:02 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:32:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:02 INFO - 'USER': 'cltbld', 09:32:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:02 INFO - 'XPC_FLAGS': '0x0', 09:32:02 INFO - 'XPC_SERVICE_NAME': '0', 09:32:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:32:03 INFO - Cleaning up... 09:32:03 INFO - Return code: 0 09:32:03 INFO - Running post-action listener: _resource_record_post_action 09:32:03 INFO - Running post-action listener: _start_resource_monitoring 09:32:03 INFO - Starting resource monitoring. 09:32:03 INFO - [mozharness: 2017-02-23 17:32:03.151339Z] Finished create-virtualenv step (success) 09:32:03 INFO - [mozharness: 2017-02-23 17:32:03.152269Z] Running install step. 09:32:03 INFO - Running pre-action listener: _resource_record_pre_action 09:32:03 INFO - Running main action method: install 09:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:03 INFO - Reading from file tmpfile_stdout 09:32:03 INFO - Detecting whether we're running mozinstall >=1.0... 09:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:32:03 INFO - Reading from file tmpfile_stdout 09:32:03 INFO - Output received: 09:32:03 INFO - Usage: mozinstall [options] installer 09:32:03 INFO - Options: 09:32:03 INFO - -h, --help show this help message and exit 09:32:03 INFO - -d DEST, --destination=DEST 09:32:03 INFO - Directory to install application into. [default: 09:32:03 INFO - "/builds/slave/test"] 09:32:03 INFO - --app=APP Application being installed. [default: firefox] 09:32:03 INFO - mkdir: /builds/slave/test/build/application 09:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:32:23 INFO - Reading from file tmpfile_stdout 09:32:23 INFO - Output received: 09:32:23 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:32:23 INFO - Running post-action listener: _resource_record_post_action 09:32:23 INFO - [mozharness: 2017-02-23 17:32:23.814168Z] Finished install step (success) 09:32:23 INFO - [mozharness: 2017-02-23 17:32:23.814331Z] Running run-tests step. 09:32:23 INFO - Running pre-action listener: _resource_record_pre_action 09:32:23 INFO - Running main action method: run_tests 09:32:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:32:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:32:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:32:23 INFO - 2017-02-23 09:32:23.829 screenresolution[1990:15758] starting screenresolution argv=screenresolution get 09:32:23 INFO - 2017-02-23 09:32:23.831 screenresolution[1990:15758] Display 0: 1600x1200x32@60 09:32:23 INFO - 2017-02-23 09:32:23.837 screenresolution[1991:15760] starting screenresolution argv=screenresolution list 09:32:23 INFO - Available Modes on Display 0 09:32:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:32:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:32:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:32:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:32:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:32:24 INFO - Intel Iris: 09:32:24 INFO - Chipset Model: Intel Iris 09:32:24 INFO - Type: GPU 09:32:24 INFO - Bus: Built-In 09:32:24 INFO - VRAM (Dynamic, Max): 1536 MB 09:32:24 INFO - Vendor: Intel (0x8086) 09:32:24 INFO - Device ID: 0x0a2e 09:32:24 INFO - Revision ID: 0x0009 09:32:24 INFO - Displays: 09:32:24 INFO - Display: 09:32:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:32:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:32:24 INFO - Display Serial Number: 1600x1200 60 09:32:24 INFO - Main Display: Yes 09:32:24 INFO - Mirror: Off 09:32:24 INFO - Online: Yes 09:32:24 INFO - Rotation: Supported 09:32:24 INFO - Return code: 0 09:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:32:24 INFO - Python 2.7.3 09:32:24 INFO - Return code: 0 09:32:24 INFO - grabbing minidump binary from tooltool 09:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:24 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 0x102dd3d30>, '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 0x102cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dc8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:32:24 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 09:32:24 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 09:32:24 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 09:32:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:32:24 INFO - Return code: 0 09:32:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:32:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:32:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:32:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:32:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0137 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PFYllRUKET/Render', 09:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:24 INFO - 'HOME': '/Users/cltbld', 09:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:24 INFO - 'LOGNAME': 'cltbld', 09:32:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:32:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:24 INFO - 'MOZ_NO_REMOTE': '1', 09:32:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:32:24 INFO - 'NO_EM_RESTART': '1', 09:32:24 INFO - 'PAGER': '/bin/cat', 09:32:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:24 INFO - 'PWD': '/builds/slave/test', 09:32:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:24 INFO - 'SHELL': '/bin/bash', 09:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jo052fTBG7/Listeners', 09:32:24 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 09:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:24 INFO - 'USER': 'cltbld', 09:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:24 INFO - 'XPC_FLAGS': '0x0', 09:32:24 INFO - 'XPC_SERVICE_NAME': '0', 09:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:32:24 INFO - mozversion application_buildid: 20170223073922 09:32:24 INFO - mozversion application_changeset: 7808ea875b492d7582f33020d604afa971d4ba67 09:32:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:32:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:32:24 INFO - mozversion application_name: Firefox 09:32:24 INFO - mozversion application_remotingname: firefox-dev 09:32:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:32:24 INFO - mozversion application_vendor: Mozilla 09:32:24 INFO - mozversion application_version: 53.0a2 09:32:24 INFO - mozversion platform_buildid: 20170223073922 09:32:24 INFO - mozversion platform_changeset: 7808ea875b492d7582f33020d604afa971d4ba67 09:32:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:32:24 INFO - mozversion platform_version: 53.0a2 09:32:24 INFO - using testdate: 1487871144 09:32:24 INFO - actual date: 1487871144 09:32:24 INFO - starting webserver on 'localhost:51260' 09:32:24 INFO - SUITE-START | Running 2 tests 09:32:24 INFO - TEST-START | dromaeo_css 09:32:24 INFO - operating with platform_type : mac_ 09:32:24 INFO - Initialising browser for dromaeo_css test... 09:32:24 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpmk7TXr/profile http://localhost:51260/getInfo.html) 09:32:27 INFO - PROCESS | 2001 | 2017-02-23 09:32:27.065 plugin-container[2003:15932] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 09:32:27 INFO - PROCESS | 2001 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:32:27 INFO - PROCESS | 2001 | 2017-02-23 09:32:27.069 plugin-container[2003:15932] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9043, name = 'com.apple.CFPasteboardClient' 09:32:27 INFO - PROCESS | 2001 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:32:27 INFO - PROCESS | 2001 | 2017-02-23 09:32:27.069 plugin-container[2003:15932] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:32:27 INFO - PROCESS | 2001 | __metrics Screen width/height:1600/1200 09:32:27 INFO - PROCESS | 2001 | colorDepth:24 09:32:27 INFO - PROCESS | 2001 | Browser inner width/height: 1024/689 09:32:27 INFO - PROCESS | 2001 | __metrics 09:32:27 ERROR - PROCESS | 2001 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 09:32:27 INFO - TEST-INFO | 2001: exit 0 09:32:27 INFO - Browser initialized. 09:32:27 INFO - Running cycle 1/1 for dromaeo_css test... 09:32:27 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpmk7TXr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:30 INFO - PROCESS | 2004 | 2017-02-23 09:32:30.489 plugin-container[2005:16064] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 09:32:30 INFO - PROCESS | 2004 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:32:30 INFO - PROCESS | 2004 | 2017-02-23 09:32:30.489 plugin-container[2005:16064] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 09:32:30 INFO - PROCESS | 2004 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:32:30 INFO - PROCESS | 2004 | 2017-02-23 09:32:30.490 plugin-container[2005:16064] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:32:40 INFO - PROCESS | 2004 | RSS: Main: 218693632 09:32:40 INFO - PROCESS | 2004 | 09:35:42 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:51260/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51260/tests/dromaeo/cssquery-ext.html) 09:35:44 INFO - PROCESS | 2004 | RSS: Main: 239226880 09:35:44 INFO - PROCESS | 2004 | 09:37:28 INFO - PROCESS | 2004 | ************************* 09:37:28 INFO - PROCESS | 2004 | A coding exception was thrown and uncaught in a Task. 09:37:28 INFO - PROCESS | 2004 | 09:37:28 ERROR - PROCESS | 2004 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:37:28 INFO - PROCESS | 2004 | Full stack: 09:37:28 INFO - PROCESS | 2004 | ************************* 09:38:46 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:51260/tests/dromaeo/cssquery-ext.html (next: http://localhost:51260/tests/dromaeo/cssquery-jquery.html) 09:38:47 INFO - PROCESS | 2004 | RSS: Main: 250728448 09:38:47 INFO - PROCESS | 2004 | 09:41:49 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:51260/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51260/tests/dromaeo/cssquery-mootools.html) 09:41:49 INFO - PROCESS | 2004 | RSS: Main: 258101248 09:41:49 INFO - PROCESS | 2004 | 09:44:51 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:51260/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51260/tests/dromaeo/cssquery-prototype.html) 09:44:52 INFO - PROCESS | 2004 | RSS: Main: 254595072 09:44:52 INFO - PROCESS | 2004 | 09:47:55 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:51260/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51260/tests/dromaeo/cssquery-yui.html) 09:47:56 INFO - PROCESS | 2004 | RSS: Main: 258560000 09:47:56 INFO - PROCESS | 2004 | 09:50:58 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:51260/tests/dromaeo/cssquery-yui.html (next: http://localhost:51260/tests/dromaeo/cssquery-dojo.html) 09:50:59 INFO - PROCESS | 2004 | RSS: Main: 259768320 09:50:59 INFO - PROCESS | 2004 | 09:50:59 INFO - PROCESS | 2004 | __start_tp_report 09:50:59 INFO - PROCESS | 2004 | _x_x_mozilla_page_load 09:50:59 INFO - PROCESS | 2004 | _x_x_mozilla_page_load_details 09:50:59 INFO - PROCESS | 2004 | |i|pagename|runs| 09:50:59 INFO - PROCESS | 2004 | |0;dojo.html;3339.649336819634;3359.4792807114904;3380.154961259685;3380.357732030914;3423.845926933288;5691.1178767291085;5691.857703557408;5757.884842303151;5761.711914404279;5780.335261444935;5699.401562835905;5737.770489180428;5752.626079304842;5775.5957083004105;5780.335261444935;4316.784160791964;5252.868678283045;5263.394709608387;5311.123664595337;5318.654287471321;5236.92144617831;5250.976059668366;5359.839204823842;5370.677759334433;5380.381256155553;5148.485151484859;5184;5203.219517072432;5210.166373380241;5250.789968401259;5180.507851754115;5230.450802665703;5245.842624721265;5278.419373868871;5279.762410691528;5176.120059589841;5200.271961925334;5209.791608335662;5225.764840582145;5278.947210527884;4828.927566086511;5467.507924286833;5516.172574113875;5574.86062848432;5648.322201335866;6217.160683307741;6257.8748425031245;6259.530535209878;6288.3397243289255;6294.874102517924;6250.249970003629;6260.499160067184;6260.499160067229;6262.843428914268;6280.654563998978;5684.573656975744;5878.764849406019;5895.233619629506;5908.586398952075;5915.497182739516;5680.715964201856;5868.620874094584;6274.686265686697;6314.02132669437;6379.808605741835;6149.96925015372;6168.8766224675255;6194.907076393858;6204.193454850841;6236.812895613139;6279.780207692709;6288.968555157195;6306;6312.715927783261;6346.11154438379;6128.289244084599;6187.690615469209;6228.096925945712;6251.218597675291;6265.624062556261;5280.759021629914;5993.640381577119;6308.148399966038;6314.71583778731;6351.364863513611;4192.4759405074365;4368.890777730582;5004.224345226496;5038.319826823332;5044.722540260321;4421.11577684458;4437.844675436344;4481.820727170877;4493.640508759291;4507.661925355612;5008.474110218447;5010.599152067826;5538.726092998633;5990.73041713124;6035.8792824143275;5706;5720.513756330675;6238.157848690459;6240.219972503437;6317.210348706411;5838.737256823369;5914.408559144137;5981.102834574762;5989.730462129215;6073.99779036454;4653.697509661861;5504.174373843875;5511.559075274049;5513.669179849222;5514.558835293167;6242.438180563771;6453;6459.547831651739;6467;6490.123833282447;6182.629042257479;6216.813495595139;6227.252729672468;6239.937600623935;6308.022256550242;5284.41871394154;6414.935850641434;6466.127072845105;6489.513286503437;6530.118434011348;5003.374578177728;6254.749810007549;6268.811935641938;6269.874602507833;6276.1213430118905;6049.727762250621;6145.016797312409;6145.324014358328;6173.567850250619;6208.782692605737;6109.541784366102;6124.693765311627;6168.568200225941;6174.722137503913;6192.690365481798;5104;6214.098955651496;6241.937580624317;6242.875142497215;6246.531510136667;5826.155207494974;5860.941390586039;5977.402259773988;6012.789552365646;6137.447629713347;6113.537117903944;6200.937990620217;6205.81382558524;6206.410391012847;6214.533909956862;6068.6358818471035;6082.187949496592;6082.391760823883;6089.056196289582;6090.056041313604 09:50:59 INFO - PROCESS | 2004 | |1;ext.html;440.2383875894701;457.2364151866385;497.9128652485814;552.4779083765843;554.5923746046655;36785;39368.409473857915;39381;39393;39459.60540394595;40256;41172.794136029355;41215.793921030425;41220.17559648813;41290.17419651613;8420.957895210515;8609.39734218605;9085;9432.952835235814;10634.202434817382;11121.332720036784;11303.321800691943;11318;11388.54445822166;11412.429378531082;11360.318380897132;11392.316461012366;11438.256513326649;11440.256383335098;11452.141089418285;10074.546645400902;10941.288816227;11332.320060796337;11375.772484550345;11413.48639311233;11291;11316.151288653384;11397.943010284978;11408.429578521042;11410.258333208314;39481.21037579261;39823;39870.800645996875;39889.601103988876;40058.799706001286;3942;3978.562358140602;4002.939955900664;4026.8187931543152;4028.4964379452567;28564.285892852844;29359.706402936125;29733.405331893457;30887.69112308893;30916.53625195624;2964.7183517565795;2978.7616990640695;3022.425739109562;3091.4280858041334;3242.6757324267383;425758;425900.9999999969;429418;439280.8035959832;440509;46248.768756156;56504.717476412356;56746.71626641841;56796.432035679114;56884;58232.41767582355;58577;58649;58731;58823.70588147118;13010.804837927439;15430.614234644;15573.065616063073;15748.370065197263;15850.048997059983;11008.229423940247;11336.71658208535;12096.455659495345;12253.877461225451;12428.62714118578;17694.115294235493;17889;17927.462176134737;17993.550161246072;18035.368762093265;7959.8408031839035;8039.598020099089;8078.43450958439;8129.959350203329;8155.510669359857;854.722215280024;868.1448772958631;870.3515880668942;874.4228808986165;901.9594118264694;29128.7087129126;29729.1233528278;30153.849230753705;30254.84872575623;30257.60609586227;878.4290211362666;1061.135174832509;1068;1080.5785743560018;1229.557359350633;14758.483453079305;15029.323680434407;15467.99458035224;15675.921620391826;15843.920780396023;667205;674613;675707;676506;676661;58945.115823262684;59461.81076378448;59697;59760.70119649374;59861.40138598646;1422.5803388000566;1441.2577522575673;1467.7871708602192;1469.4856800119871;1470.037125682701;24675.259742207763;28978.56532151977;29530.409391812474;29575.85212073926;30053.849730751208;49494;49866;49984;50029;50053.74973125111;474762;475739;475898;476395;477499;21218.57562848765;24840.37899052466;26316.736832631428;26671.33321666974;26708;35652.64347356597;40719.38920916248;41313.380299296135;41342;42208;34384.65615343815;35451;35488;35686.107847304025;36719.63280367162;35017.64982350144;35120.12199695028;35911.82044089763;35997.1000724984;36528.26943461169;33529.83235083809;33800.3239935195;33865.66134338625;34389.65610343964;34751;29991.550126748552;31384.529232061082;31611.683883160873;31634.525482118246;32040.5193922096;18726.81273187305;23560.175393861133;23724.881375593013;23843.534879097257;24036.158734444212 09:50:59 INFO - PROCESS | 2004 | |2;jquery.html;350.29765320532334;384.5289520337585;397.60438363827984;407.31570960785865;422.30530776872047;19381;20777.376678699624;21155.788442115594;21254.043568039437;21351.893240533813;20797.16811327545;20919.954002299863;21163.78836211641;21378.679319810217;21631.891840540775;5713.371529131792;5759.971200144004;5980.820575382745;6065.636061836304;6114.266288045441;3937.448757173998;4488.326750987361;6022.969885150568;6034.155218269446;6062.757489700407;5999.970000149993;6088.634681919099;6092;6107.267127944653;6122.204113465265;5894.793682221101;6005.939940600581;6051.757929682852;6090.786822461215;6105.236845394325;5801.8549536261935;5956.821295361146;5965.970170149121;5973.223480947492;5973.731182096816;13420;13420.798688019688;13555.593332199951;13576.1854288742;15940.123293218869;2544.3639090227443;2607.8435293882426;2659.2687011071916;2663.387420893186;2684.6509953705895;8169.836603267901;9964.252681048878;10115.747106322327;10349.793004139876;10399.220058495643;1782.1712903499936;1794.4257837492007;1830.8901465912088;1845.2618952419004;1866.2550515268267;141268.2936585321;147460;151072.2446387772;152819;154778;11796.52813887435;11909.523619055313;12133.5146594137;12181.512739490498;12196.268223906594;15663.451779187903;15807.13060781668;15811.920940395454;15815.841841581667;15820.92089539568;8286.254237118688;8551.700690475804;8595.828083438297;8674.56627168639;8691.739247822576;8175.386845986574;8177.304929080976;8177.5502347370275;8313.750587482386;8324.458910170819;3932.820153953802;4807;4843.927341089887;4848.418189817245;4931.4821943696115;1695.4066076872996;2023.9898800505903;2042.2874812947732;2075.2529089527757;2081.427607407945;848.4866655673229;859.6776208921655;872.47651409154;877.5699907045502;913.5249670171473;20981.370558883256;21423.571528569653;21540.569188616453;21619.783802162092;21673.67489487659;903.0788595632549;909.9135582119688;914.5153068873508;925.2366797392178;936.4053825820516;11042.668719938414;11298.491567879466;11346.773064538664;11350.829737553944;11362.375069371099;759307;761425;770072;770806;774394;134484.65515344916;138572;156138;159479.40520594877;160495.5925661116;846.7798372423214;879.9692010779592;1054.0987455725399;1068.2255364860569;1073.2969904712427;19117.426477205707;19608.607827843647;19957.800421995595;20030.391490382717;20066.899665502162;54892.72553637206;62958.685206573675;64746.35253647592;65148.674256628416;65726.67136664285;65861.67069164623;80717.57847264591;82724.01362106556;87775;91405.54297228737;7945.6027198640995;8540;8714.956425217833;8816.779580510538;8895.154960278764;11873.465694043616;13311;13397.933010334886;13558.050936434354;13602.591922242349;11322.660320190407;11323.490442929924;11487.483063262007;11587.420628968686;11999.580014699444;11243;11293.548258069584;11647.88352116468;11789.292642441482;11806.586769463027;11435.256708313933;11623.476943537731;11799.882001180222;11966.22219555726;12059.21615095016;6333.96833015832;7449.106107267163;7490.775276741707;7667.233276672288;8593.52735599548;11582.536698531965;11977.700557486132;12019.63941081769;12028.819567706316;12046.397680115784 09:50:59 INFO - PROCESS | 2004 | |3;mootools.html;1415.179196066281;1427.8643528864757;1428.1859340176097;1432.226597637276;1438.1011867582763;7504.399648028145;7762.379009679226;8080.070791858938;8529.530875801836;8547.48715077095;8149.103598604149;8423.536705481196;8429.536375499345;8493.193146651074;8556.871646925301;2340.5435939991753;2377.583922813509;2390.6294524348755;2391.4021494626345;2392.736798952114;2110.810027097561;2188.4638263625434;2365.787079162875;2403.7836594706473;2411.2886698423918;2282.395165281202;2346.401667574766;2357.54027964547;2364.43253619131;2378.108209421467;2354.75275096115;2356.658284548748;2366.9053237870467;2368.7631236876173;2374.3945293950105;2346.5189636124724;2359.079958816063;2381.6784734061025;2403.651470536762;2409.4699166183414;8525.01962274334;8576.228139467477;8626.482411055356;8635.568221588896;8657;5128.794848206067;5293.761780719877;5294.894102117974;5300.761465734051;5312.415634280226;3388.102152929476;3616.1682812952904;3642.6357364263627;3671.008827616555;3691.6123807000417;1193.5225909636129;1235.234154824015;1273.312411297898;1281.6027031620135;1285.13895689888;10937.179711521667;11012.229143959927;11082.722931926766;11087.944560277228;11103.72240693989;4668.906621867612;4848.442429120626;4849.660523763373;4858.4898585648;4881.438634557071;8835.028146903835;8885.244754195837;8936.41913275635;8940.68707595244;8949;5205.531502164823;5242.449542798027;5250.054990101742;5250.711210883362;5265.420803711589;3827.4258861171047;4622;4851.636127290397;4925.827596034122;4940.851774446773;3727.5154229949935;3807.8667246646232;3832.5209348831395;3864.632859878307;3904.1801221743754;1078.741102135482;1105.745678493951;1140.6007897236068;1164.5807509296815;1179.3572502985894;773.2615352338503;846.6486408140676;876.1720174435225;902.41794042842;919.2645883293338;5545.085060964976;5576.219329293902;5637.379888212294;5699.943000570024;5872.2366092408565;961.403929563661;976.1019861727228;1000.3147843726924;1017.2929813779352;1028.1466382902174;3674.6325367463573;3700.296943580711;3778.0932576181517;3821.8662346818282;3862.343401621731;9967.10296073357;10231.539580718885;10324.277300588887;10333;10348;10144.594216231415;10264.692059238234;10274.845877311845;10285.74285642865;10305.227107966932;7424.406047516186;7869.134395216636;7901.960490197513;8007.199280071946;8071.838563228703;5707.543396528351;5733.369329373682;5838.416158384128;5846.181534585076;5873.618214816023;8915.108489151033;8969.955150224207;9062;9222.95388523053;9226.031266717167;9316.627334906529;9373.390729602554;9492.762680933032;9502.524873756423;9561.856572151562;7214.170370407261;7350.669219885225;7383.520071195355;7386.667599957907;7389.519681220703;6420.55056146084;7991.400644951768;8009.759707208793;8024.679012839421;8127.1466496017065;6118.235220597426;7215.963920180366;7257.0565826442225;7300.196978332273;7366.558006519626;7076.752313668997;7097.25478824716;7109.431245500451;7121.074260346122;7125.429965602636;5397.217403476552;5437;6386.552941294065;6432.646204458612;6505.772297969548;4925.670069081256;4949.876253093701;4981.651284410056;5000.374953130859;5002.374703162105;4958.057968985881;5083.669561478492;5130.923036154386;5139.563137133236;5152.76812543444 09:50:59 INFO - PROCESS | 2004 | |4;prototype.html;310.72656062664856;351.57108327840024;371.1556209623108;374.74330083892517;380.17881376227353;5206.739663016843;5225.581953443725;5373.543248823855;5458.863528411792;5507.807226747064;4585.899384147806;4804.519548045194;5037.974810125954;5196.532312091911;5364.302640656719;4211.43145675333;4252.340887162495;4265.480978192988;4276.208901353252;4292.098659281554;3554.222888555722;3873.3412428589863;3986.9202615947665;3996.680265578747;4193.134055345373;4165.66674666026;4168.5623009584015;4190.895227619303;4213.768242746648;4225.704200705952;3863.072862512991;4167.645750111229;4183.45615070042;4221.662267018631;4256.36154576816;2816.4085542036196;2972.271793410628;2990.8335749057883;3712.3688972874675;3735.383661695817;4341.413909122291;4903.828366007173;5184.300119483859;5204.973975130138;5261.579073674096;4214.346776249687;4584.312353147021;4676.625869930397;4684.1731724627425;4684.625229981593;5395.325584301962;5687.658740475585;5708.943845388616;5721.513671337942;5731.856703582402;3449.258409441982;3852.5376954765607;3938.4879965604573;3941.467901833273;3963.286608410485;5657.915131273035;5659.943400566024;5931.347551769302;5946.108083787466;6012.30858451275;2927.751141152983;3912.921741565153;3969.8412063517135;3970.960290397059;4045.7774822384463;3714.591394946554;3962.9696278967676;4011.919761604752;4023.6781057515327;4053.4730485036757;4643.721376717408;4647.767611619405;4678.812847486062;4704.153252414599;4748.596369308579;4801.879953001133;5487.396386397493;5580.441955804387;5724.599278050497;5739.253896993364;1117.1956191542076;1141.2125633312987;1166.3759888459633;1193.3376975778353;1293.624848793858;801.6072124658991;829.2461444045799;841.667541321187;865.6494119881459;889.666375109334;5103.8724031898755;5184.403793563789;5189.299444574934;5202.479752024768;5252.185911183773;5575.52608028314;5582.748776305076;5595.677793715562;5654.236678048411;5716.199397189872;4228.725132866354;4643.791029403685;4906.828261010919;5014.147594908874;5123.359580052494;2447.2168905949925;2914.2568644995813;2946.145617770865;2968.5101958177092;2981.9573592089055;5816;5901.3508514063415;5910.542332735398;5911.866710643366;5967.880642387215;4788.366398480822;4945.653804233669;5013.623978201649;5299.867503312448;5443.482869127427;5435.891282174413;5781.335146458127;5828.368056944062;5861.736221869941;5882.617629854046;4745.525447455227;4833.419989601271;4993.302277225761;5328.7602057906715;5542.418046105101;4833.009233107275;5177.301064356264;5205.505476979681;5462.289902312674;5588.497035266845;4744.861233304051;5280.287161233185;5330.0963113934495;5844.094165404199;5882.647041177543;3419.8803041893416;3479.443289073736;3635.654612811779;3775.037365471897;3790.4693342932565;4701.529847015271;5073.822416215415;5351.866203344792;5458.590605704509;5593.356763972195;4725.740084295397;5301.734913254245;5523.502884740393;5659.151127330769;5682.318121825408;4629.791659375269;4891.095147397743;5427.83716488506;5677.630953987978;5704.857378565569;5256.4480729524375;5280.603954703336;5562.471565201299;5585.240649195491;5623.325200975909;4572.954270457253;5189.662671926313;5296.523312901857;5668.03643380618;5679.444250087559;4508.391367165391;5533.501984821385;5578.852141925307;5624.690642014729;5629.874025195059 09:50:59 INFO - PROCESS | 2004 | |5;yui.html;676.5906626490976;676.9830754231147;759.889815976683;810.2586480482386;813.6479042627428;14743.11541307521;15372.154531500762;15430.537083887488;15443.613909652264;15507.68984620307;11847.46686399112;13871.514496992608;14347.42610295587;14410.711785764304;14478.638034049154;835.089752170136;844.6494704697543;852.735651947895;852.7441767469734;853.8206976534904;689.1282527602586;711.4557363616838;827.1728271728272;849.5327569836596;850.5109562001843;892.9419587726777;906.419891269588;910.1808372464768;911.4804561400005;911.9498427586481;762.9542227466342;896.7085697148453;904.2449554621899;905.1762895764822;908.9910199678352;665.5640555436197;673.804596666966;674.0866126398757;674.912261406019;676.3202981004059;14611.561653150422;14835.25823708821;15006.62483437912;15032.248387580577;15368.077915325117;14233.146011239256;14521.128732276096;14678.266086695729;14699.338529766186;14761.114333139938;11342.033347855371;11742.941285293518;11771.64685059441;11778.882211177865;11906.226095303777;3615.023943535257;3635.1093981974323;3699.1134521394283;3744.6817020553285;3851.1527463957887;88270.11729882748;100372;101300;101386.49306753493;103465.4826725869;7905.367570594339;10574.629887953884;10598.470076496144;10671.946640266904;10752.569897204181;21234.78765212359;21368.679469807965;21412.464688382603;21619.027143778567;21740.347789566338;7489.887651685229;7550.471466997367;7584.734534291273;7637.6563054661565;7722.498037627649;3595.2449985503335;4166.583341665809;4167;4188.937165942513;4190.895227619334;2912.6504819421807;3358.5130156127225;3402.727781777452;3426.8629254830025;3435.381631306339;629.8866204083309;634.5970308853911;657.6317262333109;658.1937127019363;661.1504217081027;613.6686189457732;647.1102234427661;657.063684249942;665.896785998171;679.8245614035009;9292.95353523228;9850.901490985141;9884.752881178028;9902.059304366074;9984.850227246598;587.9735411906474;624.2259598098416;626.7712285016028;646.4549726154495;673.3233100733829;4642.141203877293;4690.663160999167;4734.597559207506;4741.5495527924795;4757.119932812371;71752.64123679348;74749.25250747532;78535.60732196417;81691;88752.55623721969;72951.63524182345;75407.86888196682;76093;78156;79113.20886791058;69976.6501167491;70274.64862675757;72359;72561.2743872565;74029.5194096115;10240.385576865412;10633.468326583485;10725.839112413163;10837.729056773644;10874.510647020745;43210.78394608007;44069.11861762811;44091.77954110209;44352.11295774002;44873.10253794971;45605.77197113993;54551.6362090935;55621.721891391906;56945.29164125083;58793;12586.559470418491;12675.17611355259;12721.982241420848;13242;13482.19106853592;12524.998000159783;14070.859291406954;14302.113512465632;14462.493812716504;14528.709425811636;13090.280034597808;13098.672533186365;13353;14011.859881401055;14031;12930.353482326034;13201.933990329986;13544.322783860966;13567.118137321042;13942.930285348508;13115.93442032822;13270.933645331712;13296;13303.534376296782;13319.866801331862;9333.439993600407;9751.853722194315;10074.54664540112;10239.795204096024;10612.628558000433;10017.098461138532;10057.748556285858;10061.195104391485;10064.44645544502;10077.596896124367 09:50:59 INFO - PROCESS | 2004 | __end_tp_report 09:50:59 INFO - PROCESS | 2004 | __start_cc_report 09:50:59 INFO - PROCESS | 2004 | _x_x_mozilla_cycle_collect,392 09:50:59 INFO - PROCESS | 2004 | __end_cc_report 09:50:59 INFO - PROCESS | 2004 | __startTimestamp1487872259077__endTimestamp 09:50:59 INFO - PROCESS | 2004 | 09:50:59 INFO - PROCESS | 2004 | ------- Summary: start ------- 09:50:59 INFO - PROCESS | 2004 | Number of tests: 6 09:50:59 INFO - PROCESS | 2004 | 09:50:59 INFO - PROCESS | 2004 | [#0] dojo.html Cycles:165 Average:5730.25 Median:5989.73 stddev:680.58 (11.4%) stddev-sans-first:656.32 09:50:59 INFO - PROCESS | 2004 | Values: 3339.6 3359.5 3380.2 3380.4 3423.8 5691.1 5691.9 5757.9 5761.7 5780.3 5699.4 5737.8 5752.6 5775.6 5780.3 4316.8 5252.9 5263.4 5311.1 5318.7 5236.9 5251.0 5359.8 5370.7 5380.4 5148.5 5184.0 5203.2 5210.2 5250.8 5180.5 5230.5 5245.8 5278.4 5279.8 5176.1 5200.3 5209.8 5225.8 5278.9 4828.9 5467.5 5516.2 5574.9 5648.3 6217.2 6257.9 6259.5 6288.3 6294.9 6250.2 6260.5 6260.5 6262.8 6280.7 5684.6 5878.8 5895.2 5908.6 5915.5 5680.7 5868.6 6274.7 6314.0 6379.8 6150.0 6168.9 6194.9 6204.2 6236.8 6279.8 6289.0 6306.0 6312.7 6346.1 6128.3 6187.7 6228.1 6251.2 6265.6 5280.8 5993.6 6308.1 6314.7 6351.4 4192.5 4368.9 5004.2 5038.3 5044.7 4421.1 4437.8 4481.8 4493.6 4507.7 5008.5 5010.6 5538.7 5990.7 6035.9 5706.0 5720.5 6238.2 6240.2 6317.2 5838.7 5914.4 5981.1 5989.7 6074.0 4653.7 5504.2 5511.6 5513.7 5514.6 6242.4 6453.0 6459.5 6467.0 6490.1 6182.6 6216.8 6227.3 6239.9 6308.0 5284.4 6414.9 6466.1 6489.5 6530.1 5003.4 6254.7 6268.8 6269.9 6276.1 6049.7 6145.0 6145.3 6173.6 6208.8 6109.5 6124.7 6168.6 6174.7 6192.7 5104.0 6214.1 6241.9 6242.9 6246.5 5826.2 5860.9 5977.4 6012.8 6137.4 6113.5 6200.9 6205.8 6206.4 6214.5 6068.6 6082.2 6082.4 6089.1 6090.1 09:50:59 INFO - PROCESS | 2004 | 09:50:59 INFO - PROCESS | 2004 | [#1] ext.html Cycles:180 Average:65876.53 Median:34884.32 stddev:143834.20 (412.3%) stddev-sans-first:144153.78 09:50:59 INFO - PROCESS | 2004 | Values: 440.2 457.2 497.9 552.5 554.6 36785.0 39368.4 39381.0 39393.0 39459.6 40256.0 41172.8 41215.8 41220.2 41290.2 8421.0 8609.4 9085.0 9433.0 10634.2 11121.3 11303.3 11318.0 11388.5 11412.4 11360.3 11392.3 11438.3 11440.3 11452.1 10074.5 10941.3 11332.3 11375.8 11413.5 11291.0 11316.2 11397.9 11408.4 11410.3 39481.2 39823.0 39870.8 39889.6 40058.8 3942.0 3978.6 4002.9 4026.8 4028.5 28564.3 29359.7 29733.4 30887.7 30916.5 2964.7 2978.8 3022.4 3091.4 3242.7 425758.0 425901.0 429418.0 439280.8 440509.0 46248.8 56504.7 56746.7 56796.4 56884.0 58232.4 58577.0 58649.0 58731.0 58823.7 13010.8 15430.6 15573.1 15748.4 15850.0 11008.2 11336.7 12096.5 12253.9 12428.6 17694.1 17889.0 17927.5 17993.6 18035.4 7959.8 8039.6 8078.4 8130.0 8155.5 854.7 868.1 870.4 874.4 902.0 29128.7 29729.1 30153.8 30254.8 30257.6 878.4 1061.1 1068.0 1080.6 1229.6 14758.5 15029.3 15468.0 15675.9 15843.9 667205.0 674613.0 675707.0 676506.0 676661.0 58945.1 59461.8 59697.0 59760.7 59861.4 1422.6 1441.3 1467.8 1469.5 1470.0 24675.3 28978.6 29530.4 29575.9 30053.8 49494.0 49866.0 49984.0 50029.0 50053.7 474762.0 475739.0 475898.0 476395.0 477499.0 21218.6 24840.4 26316.7 26671.3 26708.0 35652.6 40719.4 41313.4 41342.0 42208.0 34384.7 35451.0 35488.0 35686.1 36719.6 35017.6 35120.1 35911.8 35997.1 36528.3 33529.8 33800.3 33865.7 34389.7 34751.0 29991.6 31384.5 31611.7 31634.5 32040.5 18726.8 23560.2 23724.9 23843.5 24036.2 09:50:59 INFO - PROCESS | 2004 | 09:50:59 INFO - PROCESS | 2004 | [#2] jquery.html Cycles:180 Average:41482.35 Median:12109.02 stddev:127947.94 (1056.6%) stddev-sans-first:128269.59 09:50:59 INFO - PROCESS | 2004 | Values: 350.3 384.5 397.6 407.3 422.3 19381.0 20777.4 21155.8 21254.0 21351.9 20797.2 20920.0 21163.8 21378.7 21631.9 5713.4 5760.0 5980.8 6065.6 6114.3 3937.4 4488.3 6023.0 6034.2 6062.8 6000.0 6088.6 6092.0 6107.3 6122.2 5894.8 6005.9 6051.8 6090.8 6105.2 5801.9 5956.8 5966.0 5973.2 5973.7 13420.0 13420.8 13555.6 13576.2 15940.1 2544.4 2607.8 2659.3 2663.4 2684.7 8169.8 9964.3 10115.7 10349.8 10399.2 1782.2 1794.4 1830.9 1845.3 1866.3 141268.3 147460.0 151072.2 152819.0 154778.0 11796.5 11909.5 12133.5 12181.5 12196.3 15663.5 15807.1 15811.9 15815.8 15820.9 8286.3 8551.7 8595.8 8674.6 8691.7 8175.4 8177.3 8177.6 8313.8 8324.5 3932.8 4807.0 4843.9 4848.4 4931.5 1695.4 2024.0 2042.3 2075.3 2081.4 848.5 859.7 872.5 877.6 913.5 20981.4 21423.6 21540.6 21619.8 21673.7 903.1 909.9 914.5 925.2 936.4 11042.7 11298.5 11346.8 11350.8 11362.4 759307.0 761425.0 770072.0 770806.0 774394.0 134484.7 138572.0 156138.0 159479.4 160495.6 846.8 880.0 1054.1 1068.2 1073.3 19117.4 19608.6 19957.8 20030.4 20066.9 54892.7 62958.7 64746.4 65148.7 65726.7 65861.7 80717.6 82724.0 87775.0 91405.5 7945.6 8540.0 8715.0 8816.8 8895.2 11873.5 13311.0 13397.9 13558.1 13602.6 11322.7 11323.5 11487.5 11587.4 11999.6 11243.0 11293.5 11647.9 11789.3 11806.6 11435.3 11623.5 11799.9 11966.2 12059.2 6334.0 7449.1 7490.8 7667.2 8593.5 11582.5 11977.7 12019.6 12028.8 12046.4 09:50:59 INFO - PROCESS | 2004 | 09:50:59 INFO - PROCESS | 2004 | [#3] mootools.html Cycles:180 Average:5480.95 Median:5135.24 stddev:2977.95 (58.0%) stddev-sans-first:2970.63 09:50:59 INFO - PROCESS | 2004 | Values: 1415.2 1427.9 1428.2 1432.2 1438.1 7504.4 7762.4 8080.1 8529.5 8547.5 8149.1 8423.5 8429.5 8493.2 8556.9 2340.5 2377.6 2390.6 2391.4 2392.7 2110.8 2188.5 2365.8 2403.8 2411.3 2282.4 2346.4 2357.5 2364.4 2378.1 2354.8 2356.7 2366.9 2368.8 2374.4 2346.5 2359.1 2381.7 2403.7 2409.5 8525.0 8576.2 8626.5 8635.6 8657.0 5128.8 5293.8 5294.9 5300.8 5312.4 3388.1 3616.2 3642.6 3671.0 3691.6 1193.5 1235.2 1273.3 1281.6 1285.1 10937.2 11012.2 11082.7 11087.9 11103.7 4668.9 4848.4 4849.7 4858.5 4881.4 8835.0 8885.2 8936.4 8940.7 8949.0 5205.5 5242.4 5250.1 5250.7 5265.4 3827.4 4622.0 4851.6 4925.8 4940.9 3727.5 3807.9 3832.5 3864.6 3904.2 1078.7 1105.7 1140.6 1164.6 1179.4 773.3 846.6 876.2 902.4 919.3 5545.1 5576.2 5637.4 5699.9 5872.2 961.4 976.1 1000.3 1017.3 1028.1 3674.6 3700.3 3778.1 3821.9 3862.3 9967.1 10231.5 10324.3 10333.0 10348.0 10144.6 10264.7 10274.8 10285.7 10305.2 7424.4 7869.1 7902.0 8007.2 8071.8 5707.5 5733.4 5838.4 5846.2 5873.6 8915.1 8970.0 9062.0 9223.0 9226.0 9316.6 9373.4 9492.8 9502.5 9561.9 7214.2 7350.7 7383.5 7386.7 7389.5 6420.6 7991.4 8009.8 8024.7 8127.1 6118.2 7216.0 7257.1 7300.2 7366.6 7076.8 7097.3 7109.4 7121.1 7125.4 5397.2 5437.0 6386.6 6432.6 6505.8 4925.7 4949.9 4981.7 5000.4 5002.4 4958.1 5083.7 5130.9 5139.6 5152.8 09:50:59 INFO - PROCESS | 2004 | 09:50:59 INFO - PROCESS | 2004 | [#4] prototype.html Cycles:180 Average:4494.83 Median:5003.46 stddev:1375.26 (27.5%) stddev-sans-first:1342.78 09:50:59 INFO - PROCESS | 2004 | Values: 310.7 351.6 371.2 374.7 380.2 5206.7 5225.6 5373.5 5458.9 5507.8 4585.9 4804.5 5038.0 5196.5 5364.3 4211.4 4252.3 4265.5 4276.2 4292.1 3554.2 3873.3 3986.9 3996.7 4193.1 4165.7 4168.6 4190.9 4213.8 4225.7 3863.1 4167.6 4183.5 4221.7 4256.4 2816.4 2972.3 2990.8 3712.4 3735.4 4341.4 4903.8 5184.3 5205.0 5261.6 4214.3 4584.3 4676.6 4684.2 4684.6 5395.3 5687.7 5708.9 5721.5 5731.9 3449.3 3852.5 3938.5 3941.5 3963.3 5657.9 5659.9 5931.3 5946.1 6012.3 2927.8 3912.9 3969.8 3971.0 4045.8 3714.6 3963.0 4011.9 4023.7 4053.5 4643.7 4647.8 4678.8 4704.2 4748.6 4801.9 5487.4 5580.4 5724.6 5739.3 1117.2 1141.2 1166.4 1193.3 1293.6 801.6 829.2 841.7 865.6 889.7 5103.9 5184.4 5189.3 5202.5 5252.2 5575.5 5582.7 5595.7 5654.2 5716.2 4228.7 4643.8 4906.8 5014.1 5123.4 2447.2 2914.3 2946.1 2968.5 2982.0 5816.0 5901.4 5910.5 5911.9 5967.9 4788.4 4945.7 5013.6 5299.9 5443.5 5435.9 5781.3 5828.4 5861.7 5882.6 4745.5 4833.4 4993.3 5328.8 5542.4 4833.0 5177.3 5205.5 5462.3 5588.5 4744.9 5280.3 5330.1 5844.1 5882.6 3419.9 3479.4 3635.7 3775.0 3790.5 4701.5 5073.8 5351.9 5458.6 5593.4 4725.7 5301.7 5523.5 5659.2 5682.3 4629.8 4891.1 5427.8 5677.6 5704.9 5256.4 5280.6 5562.5 5585.2 5623.3 4573.0 5189.7 5296.5 5668.0 5679.4 4508.4 5533.5 5578.9 5624.7 5629.9 09:50:59 INFO - PROCESS | 2004 | 09:50:59 INFO - PROCESS | 2004 | [#5] yui.html Cycles:180 Average:18455.05 Median:23700.84 stddev:25219.17 (106.4%) stddev-sans-first:25254.59 09:50:59 INFO - PROCESS | 2004 | Values: 676.6 677.0 759.9 810.3 813.6 14743.1 15372.2 15430.5 15443.6 15507.7 11847.5 13871.5 14347.4 14410.7 14478.6 835.1 844.6 852.7 852.7 853.8 689.1 711.5 827.2 849.5 850.5 892.9 906.4 910.2 911.5 911.9 763.0 896.7 904.2 905.2 909.0 665.6 673.8 674.1 674.9 676.3 14611.6 14835.3 15006.6 15032.2 15368.1 14233.1 14521.1 14678.3 14699.3 14761.1 11342.0 11742.9 11771.6 11778.9 11906.2 3615.0 3635.1 3699.1 3744.7 3851.2 88270.1 100372.0 101300.0 101386.5 103465.5 7905.4 10574.6 10598.5 10671.9 10752.6 21234.8 21368.7 21412.5 21619.0 21740.3 7489.9 7550.5 7584.7 7637.7 7722.5 3595.2 4166.6 4167.0 4188.9 4190.9 2912.7 3358.5 3402.7 3426.9 3435.4 629.9 634.6 657.6 658.2 661.2 613.7 647.1 657.1 665.9 679.8 9293.0 9850.9 9884.8 9902.1 9984.9 588.0 624.2 626.8 646.5 673.3 4642.1 4690.7 4734.6 4741.5 4757.1 71752.6 74749.3 78535.6 81691.0 88752.6 72951.6 75407.9 76093.0 78156.0 79113.2 69976.7 70274.6 72359.0 72561.3 74029.5 10240.4 10633.5 10725.8 10837.7 10874.5 43210.8 44069.1 44091.8 44352.1 44873.1 45605.8 54551.6 55621.7 56945.3 58793.0 12586.6 12675.2 12722.0 13242.0 13482.2 12525.0 14070.9 14302.1 14462.5 14528.7 13090.3 13098.7 13353.0 14011.9 14031.0 12930.4 13201.9 13544.3 13567.1 13942.9 13115.9 13270.9 13296.0 13303.5 13319.9 9333.4 9751.9 10074.5 10239.8 10612.6 10017.1 10057.7 10061.2 10064.4 10077.6 09:50:59 INFO - PROCESS | 2004 | -------- Summary: end -------- 09:50:59 INFO - PROCESS | 2004 | 09:50:59 INFO - TEST-INFO | 2004: exit 0 09:50:59 INFO - TEST-OK | dromaeo_css | took 1115277ms 09:50:59 INFO - TEST-START | kraken 09:50:59 INFO - operating with platform_type : mac_ 09:50:59 INFO - Initialising browser for kraken test... 09:50:59 INFO - TEST-INFO | started process 2009 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpG4ps26/profile http://localhost:51260/getInfo.html) 09:51:02 INFO - PROCESS | 2009 | 2017-02-23 09:51:02.284 plugin-container[2010:17990] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b43, name = 'com.apple.tsm.portname' 09:51:02 INFO - PROCESS | 2009 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:51:02 INFO - PROCESS | 2009 | 2017-02-23 09:51:02.287 plugin-container[2010:17990] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 09:51:02 INFO - PROCESS | 2009 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:51:02 INFO - PROCESS | 2009 | 2017-02-23 09:51:02.287 plugin-container[2010:17990] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:51:02 INFO - PROCESS | 2009 | __metrics Screen width/height:1600/1200 09:51:02 INFO - PROCESS | 2009 | colorDepth:24 09:51:02 INFO - PROCESS | 2009 | Browser inner width/height: 1024/689 09:51:02 INFO - PROCESS | 2009 | __metrics 09:51:02 ERROR - PROCESS | 2009 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 09:51:03 INFO - TEST-INFO | 2009: exit 0 09:51:03 INFO - Browser initialized. 09:51:03 INFO - Running cycle 1/1 for kraken test... 09:51:03 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpG4ps26/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:05 INFO - PROCESS | 2011 | 2017-02-23 09:51:05.656 plugin-container[2012:18121] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 09:51:05 INFO - PROCESS | 2011 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:51:05 INFO - PROCESS | 2011 | 2017-02-23 09:51:05.656 plugin-container[2012:18121] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c1f, name = 'com.apple.CFPasteboardClient' 09:51:05 INFO - PROCESS | 2011 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:51:05 INFO - PROCESS | 2011 | 2017-02-23 09:51:05.656 plugin-container[2012:18121] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:51:15 INFO - PROCESS | 2011 | RSS: Main: 219348992 09:51:15 INFO - PROCESS | 2011 | 09:51:18 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51260/tests/kraken/driver.html?testName=audio-beat-detection) 09:51:19 INFO - PROCESS | 2011 | RSS: Main: 233140224 09:51:19 INFO - PROCESS | 2011 | 09:51:21 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51260/tests/kraken/driver.html?testName=audio-dft) 09:51:22 INFO - PROCESS | 2011 | RSS: Main: 240918528 09:51:22 INFO - PROCESS | 2011 | 09:51:26 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51260/tests/kraken/driver.html?testName=audio-fft) 09:51:26 INFO - PROCESS | 2011 | RSS: Main: 242614272 09:51:26 INFO - PROCESS | 2011 | 09:51:28 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51260/tests/kraken/driver.html?testName=audio-oscillator) 09:51:29 INFO - PROCESS | 2011 | RSS: Main: 245338112 09:51:29 INFO - PROCESS | 2011 | 09:51:31 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51260/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:51:32 INFO - PROCESS | 2011 | RSS: Main: 245956608 09:51:32 INFO - PROCESS | 2011 | 09:51:35 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51260/tests/kraken/driver.html?testName=imaging-darkroom) 09:51:35 INFO - PROCESS | 2011 | RSS: Main: 250548224 09:51:35 INFO - PROCESS | 2011 | 09:51:38 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51260/tests/kraken/driver.html?testName=imaging-desaturate) 09:51:39 INFO - PROCESS | 2011 | RSS: Main: 249290752 09:51:39 INFO - PROCESS | 2011 | 09:51:42 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51260/tests/kraken/driver.html?testName=json-parse-financial) 09:51:43 INFO - PROCESS | 2011 | RSS: Main: 249380864 09:51:43 INFO - PROCESS | 2011 | 09:51:44 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51260/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:51:45 INFO - PROCESS | 2011 | RSS: Main: 248487936 09:51:45 INFO - PROCESS | 2011 | 09:51:47 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51260/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:51:47 INFO - PROCESS | 2011 | RSS: Main: 248586240 09:51:47 INFO - PROCESS | 2011 | 09:51:50 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51260/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:51:50 INFO - PROCESS | 2011 | RSS: Main: 248561664 09:51:50 INFO - PROCESS | 2011 | 09:51:53 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:51:54 INFO - PROCESS | 2011 | RSS: Main: 248852480 09:51:54 INFO - PROCESS | 2011 | 09:51:57 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:51:58 INFO - PROCESS | 2011 | RSS: Main: 248623104 09:51:58 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:51260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51260/tests/kraken/driver.html?testName=ai-astar) 09:52:00 INFO - PROCESS | 2011 | RSS: Main: 250589184 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | __start_tp_report 09:52:00 INFO - PROCESS | 2011 | _x_x_mozilla_page_load 09:52:00 INFO - PROCESS | 2011 | _x_x_mozilla_page_load_details 09:52:00 INFO - PROCESS | 2011 | |i|pagename|runs| 09:52:00 INFO - PROCESS | 2011 | |0;ai-astar;106;116;117;116;115;116;116;117;116;118 09:52:00 INFO - PROCESS | 2011 | |1;audio-beat-detection;149;143;112;145;113;146;143;116;133;114 09:52:00 INFO - PROCESS | 2011 | |2;audio-dft;201;198;196;197;236;293;197;286;277;199 09:52:00 INFO - PROCESS | 2011 | |3;audio-fft;82;58;59;84;59;51;75;86;98;85 09:52:00 INFO - PROCESS | 2011 | |4;audio-oscillator;89;71;82;70;74;87;115;102;81;82 09:52:00 INFO - PROCESS | 2011 | |5;imaging-gaussian-blur;136;133;89;119;136;86;92;86;90;87 09:52:00 INFO - PROCESS | 2011 | |6;imaging-darkroom;96;117;156;110;96;97;124;114;98;97 09:52:00 INFO - PROCESS | 2011 | |7;imaging-desaturate;93;96;94;91;95;90;94;106;145;113 09:52:00 INFO - PROCESS | 2011 | |8;json-parse-financial;61;59;58;62;63;64;62;64;61;62 09:52:00 INFO - PROCESS | 2011 | |9;json-stringify-tinderbox;68;69;76;77;74;71;81;74;61;86 09:52:00 INFO - PROCESS | 2011 | |10;stanford-crypto-aes;108;106;86;85;85;86;84;110;103;107 09:52:00 INFO - PROCESS | 2011 | |11;stanford-crypto-ccm;141;145;129;155;152;163;144;156;202;137 09:52:00 INFO - PROCESS | 2011 | |12;stanford-crypto-pbkdf2;204;189;172;170;167;168;168;171;213;235 09:52:00 INFO - PROCESS | 2011 | |13;stanford-crypto-sha256-iterative;60;92;89;63;85;87;86;92;75;69 09:52:00 INFO - PROCESS | 2011 | __end_tp_report 09:52:00 INFO - PROCESS | 2011 | __start_cc_report 09:52:00 INFO - PROCESS | 2011 | _x_x_mozilla_cycle_collect,970 09:52:00 INFO - PROCESS | 2011 | __end_cc_report 09:52:00 INFO - PROCESS | 2011 | __startTimestamp1487872320255__endTimestamp 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | ------- Summary: start ------- 09:52:00 INFO - PROCESS | 2011 | Number of tests: 14 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.00 stddev:3.37 (2.9%) stddev-sans-first:0.87 09:52:00 INFO - PROCESS | 2011 | Values: 106.0 116.0 117.0 116.0 115.0 116.0 116.0 117.0 116.0 118.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#1] audio-beat-detection Cycles:10 Average:131.40 Median:143.00 stddev:15.76 (11.0%) stddev-sans-first:15.37 09:52:00 INFO - PROCESS | 2011 | Values: 149.0 143.0 112.0 145.0 113.0 146.0 143.0 116.0 133.0 114.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#2] audio-dft Cycles:10 Average:228.00 Median:218.50 stddev:41.46 (19.0%) stddev-sans-first:42.81 09:52:00 INFO - PROCESS | 2011 | Values: 201.0 198.0 196.0 197.0 236.0 293.0 197.0 286.0 277.0 199.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#3] audio-fft Cycles:10 Average:73.70 Median:83.00 stddev:15.78 (19.0%) stddev-sans-first:16.45 09:52:00 INFO - PROCESS | 2011 | Values: 82.0 58.0 59.0 84.0 59.0 51.0 75.0 86.0 98.0 85.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#4] audio-oscillator Cycles:10 Average:85.30 Median:81.50 stddev:14.08 (17.3%) stddev-sans-first:14.87 09:52:00 INFO - PROCESS | 2011 | Values: 89.0 71.0 82.0 70.0 74.0 87.0 115.0 102.0 81.0 82.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#5] imaging-gaussian-blur Cycles:10 Average:105.40 Median:86.50 stddev:22.60 (26.1%) stddev-sans-first:21.08 09:52:00 INFO - PROCESS | 2011 | Values: 136.0 133.0 89.0 119.0 136.0 86.0 92.0 86.0 90.0 87.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#6] imaging-darkroom Cycles:10 Average:110.50 Median:96.00 stddev:19.00 (19.8%) stddev-sans-first:19.41 09:52:00 INFO - PROCESS | 2011 | Values: 96.0 117.0 156.0 110.0 96.0 97.0 124.0 114.0 98.0 97.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#7] imaging-desaturate Cycles:10 Average:101.70 Median:93.50 stddev:16.81 (18.0%) stddev-sans-first:17.54 09:52:00 INFO - PROCESS | 2011 | Values: 93.0 96.0 94.0 91.0 95.0 90.0 94.0 106.0 145.0 113.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.00 stddev:1.96 (3.2%) stddev-sans-first:2.06 09:52:00 INFO - PROCESS | 2011 | Values: 61.0 59.0 58.0 62.0 63.0 64.0 62.0 64.0 61.0 62.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:75.00 stddev:7.02 (9.4%) stddev-sans-first:7.14 09:52:00 INFO - PROCESS | 2011 | Values: 68.0 69.0 76.0 77.0 74.0 71.0 81.0 74.0 61.0 86.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#10] stanford-crypto-aes Cycles:10 Average:96.00 Median:84.50 stddev:11.53 (13.6%) stddev-sans-first:11.38 09:52:00 INFO - PROCESS | 2011 | Values: 108.0 106.0 86.0 85.0 85.0 86.0 84.0 110.0 103.0 107.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#11] stanford-crypto-ccm Cycles:10 Average:152.40 Median:153.50 stddev:20.09 (13.1%) stddev-sans-first:20.88 09:52:00 INFO - PROCESS | 2011 | Values: 141.0 145.0 129.0 155.0 152.0 163.0 144.0 156.0 202.0 137.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.70 Median:180.50 stddev:23.92 (13.3%) stddev-sans-first:24.43 09:52:00 INFO - PROCESS | 2011 | Values: 204.0 189.0 172.0 170.0 167.0 168.0 168.0 171.0 213.0 235.0 09:52:00 INFO - PROCESS | 2011 | 09:52:00 INFO - PROCESS | 2011 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.80 Median:86.50 stddev:12.08 (14.0%) stddev-sans-first:10.48 09:52:00 INFO - PROCESS | 2011 | Values: 60.0 92.0 89.0 63.0 85.0 87.0 86.0 92.0 75.0 69.0 09:52:00 INFO - PROCESS | 2011 | -------- Summary: end -------- 09:52:00 INFO - PROCESS | 2011 | 09:52:01 INFO - TEST-INFO | 2011: exit 0 09:52:01 INFO - TEST-OK | kraken | took 61456ms 09:52:01 INFO - SUITE-END | took 1176s 09:52:01 INFO - Completed test suite (00:19:37) 09:52:01 INFO - javascript benchmark 09:52:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7227.575680010638, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.649336819634, 3359.4792807114904, 3380.154961259685, 3380.357732030914, 3423.845926933288, 5691.1178767291085, 5691.857703557408, 5757.884842303151, 5761.711914404279, 5780.335261444935, 5699.401562835905, 5737.770489180428, 5752.626079304842, 5775.5957083004105, 5780.335261444935, 4316.784160791964, 5252.868678283045, 5263.394709608387, 5311.123664595337, 5318.654287471321, 5236.92144617831, 5250.976059668366, 5359.839204823842, 5370.677759334433, 5380.381256155553, 5148.485151484859, 5184.0, 5203.219517072432, 5210.166373380241, 5250.789968401259, 5180.507851754115, 5230.450802665703, 5245.842624721265, 5278.419373868871, 5279.762410691528, 5176.120059589841, 5200.271961925334, 5209.791608335662, 5225.764840582145, 5278.947210527884, 4828.927566086511, 5467.507924286833, 5516.172574113875, 5574.86062848432, 5648.322201335866, 6217.160683307741, 6257.8748425031245, 6259.530535209878, 6288.3397243289255, 6294.874102517924, 6250.249970003629, 6260.499160067184, 6260.499160067229, 6262.843428914268, 6280.654563998978, 5684.573656975744, 5878.764849406019, 5895.233619629506, 5908.586398952075, 5915.497182739516, 5680.715964201856, 5868.620874094584, 6274.686265686697, 6314.02132669437, 6379.808605741835, 6149.96925015372, 6168.8766224675255, 6194.907076393858, 6204.193454850841, 6236.812895613139, 6279.780207692709, 6288.968555157195, 6306.0, 6312.715927783261, 6346.11154438379, 6128.289244084599, 6187.690615469209, 6228.096925945712, 6251.218597675291, 6265.624062556261, 5280.759021629914, 5993.640381577119, 6308.148399966038, 6314.71583778731, 6351.364863513611, 4192.4759405074365, 4368.890777730582, 5004.224345226496, 5038.319826823332, 5044.722540260321, 4421.11577684458, 4437.844675436344, 4481.820727170877, 4493.640508759291, 4507.661925355612, 5008.474110218447, 5010.599152067826, 5538.726092998633, 5990.73041713124, 6035.8792824143275, 5706.0, 5720.513756330675, 6238.157848690459, 6240.219972503437, 6317.210348706411, 5838.737256823369, 5914.408559144137, 5981.102834574762, 5989.730462129215, 6073.99779036454, 4653.697509661861, 5504.174373843875, 5511.559075274049, 5513.669179849222, 5514.558835293167, 6242.438180563771, 6453.0, 6459.547831651739, 6467.0, 6490.123833282447, 6182.629042257479, 6216.813495595139, 6227.252729672468, 6239.937600623935, 6308.022256550242, 5284.41871394154, 6414.935850641434, 6466.127072845105, 6489.513286503437, 6530.118434011348, 5003.374578177728, 6254.749810007549, 6268.811935641938, 6269.874602507833, 6276.1213430118905, 6049.727762250621, 6145.016797312409, 6145.324014358328, 6173.567850250619, 6208.782692605737, 6109.541784366102, 6124.693765311627, 6168.568200225941, 6174.722137503913, 6192.690365481798, 5104.0, 6214.098955651496, 6241.937580624317, 6242.875142497215, 6246.531510136667, 5826.155207494974, 5860.941390586039, 5977.402259773988, 6012.789552365646, 6137.447629713347, 6113.537117903944, 6200.937990620217, 6205.81382558524, 6206.410391012847, 6214.533909956862, 6068.6358818471035, 6082.187949496592, 6082.391760823883, 6089.056196289582, 6090.056041313604], "value": 5688.1610503708835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.2383875894701, 457.2364151866385, 497.9128652485814, 552.4779083765843, 554.5923746046655, 36785.0, 39368.409473857915, 39381.0, 39393.0, 39459.60540394595, 40256.0, 41172.794136029355, 41215.793921030425, 41220.17559648813, 41290.17419651613, 8420.957895210515, 8609.39734218605, 9085.0, 9432.952835235814, 10634.202434817382, 11121.332720036784, 11303.321800691943, 11318.0, 11388.54445822166, 11412.429378531082, 11360.318380897132, 11392.316461012366, 11438.256513326649, 11440.256383335098, 11452.141089418285, 10074.546645400902, 10941.288816227, 11332.320060796337, 11375.772484550345, 11413.48639311233, 11291.0, 11316.151288653384, 11397.943010284978, 11408.429578521042, 11410.258333208314, 39481.21037579261, 39823.0, 39870.800645996875, 39889.601103988876, 40058.799706001286, 3942.0, 3978.562358140602, 4002.939955900664, 4026.8187931543152, 4028.4964379452567, 28564.285892852844, 29359.706402936125, 29733.405331893457, 30887.69112308893, 30916.53625195624, 2964.7183517565795, 2978.7616990640695, 3022.425739109562, 3091.4280858041334, 3242.6757324267383, 425758.0, 425900.9999999969, 429418.0, 439280.8035959832, 440509.0, 46248.768756156, 56504.717476412356, 56746.71626641841, 56796.432035679114, 56884.0, 58232.41767582355, 58577.0, 58649.0, 58731.0, 58823.70588147118, 13010.804837927439, 15430.614234644, 15573.065616063073, 15748.370065197263, 15850.048997059983, 11008.229423940247, 11336.71658208535, 12096.455659495345, 12253.877461225451, 12428.62714118578, 17694.115294235493, 17889.0, 17927.462176134737, 17993.550161246072, 18035.368762093265, 7959.8408031839035, 8039.598020099089, 8078.43450958439, 8129.959350203329, 8155.510669359857, 854.722215280024, 868.1448772958631, 870.3515880668942, 874.4228808986165, 901.9594118264694, 29128.7087129126, 29729.1233528278, 30153.849230753705, 30254.84872575623, 30257.60609586227, 878.4290211362666, 1061.135174832509, 1068.0, 1080.5785743560018, 1229.557359350633, 14758.483453079305, 15029.323680434407, 15467.99458035224, 15675.921620391826, 15843.920780396023, 667205.0, 674613.0, 675707.0, 676506.0, 676661.0, 58945.115823262684, 59461.81076378448, 59697.0, 59760.70119649374, 59861.40138598646, 1422.5803388000566, 1441.2577522575673, 1467.7871708602192, 1469.4856800119871, 1470.037125682701, 24675.259742207763, 28978.56532151977, 29530.409391812474, 29575.85212073926, 30053.849730751208, 49494.0, 49866.0, 49984.0, 50029.0, 50053.74973125111, 474762.0, 475739.0, 475898.0, 476395.0, 477499.0, 21218.57562848765, 24840.37899052466, 26316.736832631428, 26671.33321666974, 26708.0, 35652.64347356597, 40719.38920916248, 41313.380299296135, 41342.0, 42208.0, 34384.65615343815, 35451.0, 35488.0, 35686.107847304025, 36719.63280367162, 35017.64982350144, 35120.12199695028, 35911.82044089763, 35997.1000724984, 36528.26943461169, 33529.83235083809, 33800.3239935195, 33865.66134338625, 34389.65610343964, 34751.0, 29991.550126748552, 31384.529232061082, 31611.683883160873, 31634.525482118246, 32040.5193922096, 18726.81273187305, 23560.175393861133, 23724.881375593013, 23843.534879097257, 24036.158734444212], "value": 19596.021474018893, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.29765320532334, 384.5289520337585, 397.60438363827984, 407.31570960785865, 422.30530776872047, 19381.0, 20777.376678699624, 21155.788442115594, 21254.043568039437, 21351.893240533813, 20797.16811327545, 20919.954002299863, 21163.78836211641, 21378.679319810217, 21631.891840540775, 5713.371529131792, 5759.971200144004, 5980.820575382745, 6065.636061836304, 6114.266288045441, 3937.448757173998, 4488.326750987361, 6022.969885150568, 6034.155218269446, 6062.757489700407, 5999.970000149993, 6088.634681919099, 6092.0, 6107.267127944653, 6122.204113465265, 5894.793682221101, 6005.939940600581, 6051.757929682852, 6090.786822461215, 6105.236845394325, 5801.8549536261935, 5956.821295361146, 5965.970170149121, 5973.223480947492, 5973.731182096816, 13420.0, 13420.798688019688, 13555.593332199951, 13576.1854288742, 15940.123293218869, 2544.3639090227443, 2607.8435293882426, 2659.2687011071916, 2663.387420893186, 2684.6509953705895, 8169.836603267901, 9964.252681048878, 10115.747106322327, 10349.793004139876, 10399.220058495643, 1782.1712903499936, 1794.4257837492007, 1830.8901465912088, 1845.2618952419004, 1866.2550515268267, 141268.2936585321, 147460.0, 151072.2446387772, 152819.0, 154778.0, 11796.52813887435, 11909.523619055313, 12133.5146594137, 12181.512739490498, 12196.268223906594, 15663.451779187903, 15807.13060781668, 15811.920940395454, 15815.841841581667, 15820.92089539568, 8286.254237118688, 8551.700690475804, 8595.828083438297, 8674.56627168639, 8691.739247822576, 8175.386845986574, 8177.304929080976, 8177.5502347370275, 8313.750587482386, 8324.458910170819, 3932.820153953802, 4807.0, 4843.927341089887, 4848.418189817245, 4931.4821943696115, 1695.4066076872996, 2023.9898800505903, 2042.2874812947732, 2075.2529089527757, 2081.427607407945, 848.4866655673229, 859.6776208921655, 872.47651409154, 877.5699907045502, 913.5249670171473, 20981.370558883256, 21423.571528569653, 21540.569188616453, 21619.783802162092, 21673.67489487659, 903.0788595632549, 909.9135582119688, 914.5153068873508, 925.2366797392178, 936.4053825820516, 11042.668719938414, 11298.491567879466, 11346.773064538664, 11350.829737553944, 11362.375069371099, 759307.0, 761425.0, 770072.0, 770806.0, 774394.0, 134484.65515344916, 138572.0, 156138.0, 159479.40520594877, 160495.5925661116, 846.7798372423214, 879.9692010779592, 1054.0987455725399, 1068.2255364860569, 1073.2969904712427, 19117.426477205707, 19608.607827843647, 19957.800421995595, 20030.391490382717, 20066.899665502162, 54892.72553637206, 62958.685206573675, 64746.35253647592, 65148.674256628416, 65726.67136664285, 65861.67069164623, 80717.57847264591, 82724.01362106556, 87775.0, 91405.54297228737, 7945.6027198640995, 8540.0, 8714.956425217833, 8816.779580510538, 8895.154960278764, 11873.465694043616, 13311.0, 13397.933010334886, 13558.050936434354, 13602.591922242349, 11322.660320190407, 11323.490442929924, 11487.483063262007, 11587.420628968686, 11999.580014699444, 11243.0, 11293.548258069584, 11647.88352116468, 11789.292642441482, 11806.586769463027, 11435.256708313933, 11623.476943537731, 11799.882001180222, 11966.22219555726, 12059.21615095016, 6333.96833015832, 7449.106107267163, 7490.775276741707, 7667.233276672288, 8593.52735599548, 11582.536698531965, 11977.700557486132, 12019.63941081769, 12028.819567706316, 12046.397680115784], "value": 9816.317248015024, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.179196066281, 1427.8643528864757, 1428.1859340176097, 1432.226597637276, 1438.1011867582763, 7504.399648028145, 7762.379009679226, 8080.070791858938, 8529.530875801836, 8547.48715077095, 8149.103598604149, 8423.536705481196, 8429.536375499345, 8493.193146651074, 8556.871646925301, 2340.5435939991753, 2377.583922813509, 2390.6294524348755, 2391.4021494626345, 2392.736798952114, 2110.810027097561, 2188.4638263625434, 2365.787079162875, 2403.7836594706473, 2411.2886698423918, 2282.395165281202, 2346.401667574766, 2357.54027964547, 2364.43253619131, 2378.108209421467, 2354.75275096115, 2356.658284548748, 2366.9053237870467, 2368.7631236876173, 2374.3945293950105, 2346.5189636124724, 2359.079958816063, 2381.6784734061025, 2403.651470536762, 2409.4699166183414, 8525.01962274334, 8576.228139467477, 8626.482411055356, 8635.568221588896, 8657.0, 5128.794848206067, 5293.761780719877, 5294.894102117974, 5300.761465734051, 5312.415634280226, 3388.102152929476, 3616.1682812952904, 3642.6357364263627, 3671.008827616555, 3691.6123807000417, 1193.5225909636129, 1235.234154824015, 1273.312411297898, 1281.6027031620135, 1285.13895689888, 10937.179711521667, 11012.229143959927, 11082.722931926766, 11087.944560277228, 11103.72240693989, 4668.906621867612, 4848.442429120626, 4849.660523763373, 4858.4898585648, 4881.438634557071, 8835.028146903835, 8885.244754195837, 8936.41913275635, 8940.68707595244, 8949.0, 5205.531502164823, 5242.449542798027, 5250.054990101742, 5250.711210883362, 5265.420803711589, 3827.4258861171047, 4622.0, 4851.636127290397, 4925.827596034122, 4940.851774446773, 3727.5154229949935, 3807.8667246646232, 3832.5209348831395, 3864.632859878307, 3904.1801221743754, 1078.741102135482, 1105.745678493951, 1140.6007897236068, 1164.5807509296815, 1179.3572502985894, 773.2615352338503, 846.6486408140676, 876.1720174435225, 902.41794042842, 919.2645883293338, 5545.085060964976, 5576.219329293902, 5637.379888212294, 5699.943000570024, 5872.2366092408565, 961.403929563661, 976.1019861727228, 1000.3147843726924, 1017.2929813779352, 1028.1466382902174, 3674.6325367463573, 3700.296943580711, 3778.0932576181517, 3821.8662346818282, 3862.343401621731, 9967.10296073357, 10231.539580718885, 10324.277300588887, 10333.0, 10348.0, 10144.594216231415, 10264.692059238234, 10274.845877311845, 10285.74285642865, 10305.227107966932, 7424.406047516186, 7869.134395216636, 7901.960490197513, 8007.199280071946, 8071.838563228703, 5707.543396528351, 5733.369329373682, 5838.416158384128, 5846.181534585076, 5873.618214816023, 8915.108489151033, 8969.955150224207, 9062.0, 9222.95388523053, 9226.031266717167, 9316.627334906529, 9373.390729602554, 9492.762680933032, 9502.524873756423, 9561.856572151562, 7214.170370407261, 7350.669219885225, 7383.520071195355, 7386.667599957907, 7389.519681220703, 6420.55056146084, 7991.400644951768, 8009.759707208793, 8024.679012839421, 8127.1466496017065, 6118.235220597426, 7215.963920180366, 7257.0565826442225, 7300.196978332273, 7366.558006519626, 7076.752313668997, 7097.25478824716, 7109.431245500451, 7121.074260346122, 7125.429965602636, 5397.217403476552, 5437.0, 6386.552941294065, 6432.646204458612, 6505.772297969548, 4925.670069081256, 4949.876253093701, 4981.651284410056, 5000.374953130859, 5002.374703162105, 4958.057968985881, 5083.669561478492, 5130.923036154386, 5139.563137133236, 5152.76812543444], "value": 4458.567080624612, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.72656062664856, 351.57108327840024, 371.1556209623108, 374.74330083892517, 380.17881376227353, 5206.739663016843, 5225.581953443725, 5373.543248823855, 5458.863528411792, 5507.807226747064, 4585.899384147806, 4804.519548045194, 5037.974810125954, 5196.532312091911, 5364.302640656719, 4211.43145675333, 4252.340887162495, 4265.480978192988, 4276.208901353252, 4292.098659281554, 3554.222888555722, 3873.3412428589863, 3986.9202615947665, 3996.680265578747, 4193.134055345373, 4165.66674666026, 4168.5623009584015, 4190.895227619303, 4213.768242746648, 4225.704200705952, 3863.072862512991, 4167.645750111229, 4183.45615070042, 4221.662267018631, 4256.36154576816, 2816.4085542036196, 2972.271793410628, 2990.8335749057883, 3712.3688972874675, 3735.383661695817, 4341.413909122291, 4903.828366007173, 5184.300119483859, 5204.973975130138, 5261.579073674096, 4214.346776249687, 4584.312353147021, 4676.625869930397, 4684.1731724627425, 4684.625229981593, 5395.325584301962, 5687.658740475585, 5708.943845388616, 5721.513671337942, 5731.856703582402, 3449.258409441982, 3852.5376954765607, 3938.4879965604573, 3941.467901833273, 3963.286608410485, 5657.915131273035, 5659.943400566024, 5931.347551769302, 5946.108083787466, 6012.30858451275, 2927.751141152983, 3912.921741565153, 3969.8412063517135, 3970.960290397059, 4045.7774822384463, 3714.591394946554, 3962.9696278967676, 4011.919761604752, 4023.6781057515327, 4053.4730485036757, 4643.721376717408, 4647.767611619405, 4678.812847486062, 4704.153252414599, 4748.596369308579, 4801.879953001133, 5487.396386397493, 5580.441955804387, 5724.599278050497, 5739.253896993364, 1117.1956191542076, 1141.2125633312987, 1166.3759888459633, 1193.3376975778353, 1293.624848793858, 801.6072124658991, 829.2461444045799, 841.667541321187, 865.6494119881459, 889.666375109334, 5103.8724031898755, 5184.403793563789, 5189.299444574934, 5202.479752024768, 5252.185911183773, 5575.52608028314, 5582.748776305076, 5595.677793715562, 5654.236678048411, 5716.199397189872, 4228.725132866354, 4643.791029403685, 4906.828261010919, 5014.147594908874, 5123.359580052494, 2447.2168905949925, 2914.2568644995813, 2946.145617770865, 2968.5101958177092, 2981.9573592089055, 5816.0, 5901.3508514063415, 5910.542332735398, 5911.866710643366, 5967.880642387215, 4788.366398480822, 4945.653804233669, 5013.623978201649, 5299.867503312448, 5443.482869127427, 5435.891282174413, 5781.335146458127, 5828.368056944062, 5861.736221869941, 5882.617629854046, 4745.525447455227, 4833.419989601271, 4993.302277225761, 5328.7602057906715, 5542.418046105101, 4833.009233107275, 5177.301064356264, 5205.505476979681, 5462.289902312674, 5588.497035266845, 4744.861233304051, 5280.287161233185, 5330.0963113934495, 5844.094165404199, 5882.647041177543, 3419.8803041893416, 3479.443289073736, 3635.654612811779, 3775.037365471897, 3790.4693342932565, 4701.529847015271, 5073.822416215415, 5351.866203344792, 5458.590605704509, 5593.356763972195, 4725.740084295397, 5301.734913254245, 5523.502884740393, 5659.151127330769, 5682.318121825408, 4629.791659375269, 4891.095147397743, 5427.83716488506, 5677.630953987978, 5704.857378565569, 5256.4480729524375, 5280.603954703336, 5562.471565201299, 5585.240649195491, 5623.325200975909, 4572.954270457253, 5189.662671926313, 5296.523312901857, 5668.03643380618, 5679.444250087559, 4508.391367165391, 5533.501984821385, 5578.852141925307, 5624.690642014729, 5629.874025195059], "value": 4062.0474391232665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.5906626490976, 676.9830754231147, 759.889815976683, 810.2586480482386, 813.6479042627428, 14743.11541307521, 15372.154531500762, 15430.537083887488, 15443.613909652264, 15507.68984620307, 11847.46686399112, 13871.514496992608, 14347.42610295587, 14410.711785764304, 14478.638034049154, 835.089752170136, 844.6494704697543, 852.735651947895, 852.7441767469734, 853.8206976534904, 689.1282527602586, 711.4557363616838, 827.1728271728272, 849.5327569836596, 850.5109562001843, 892.9419587726777, 906.419891269588, 910.1808372464768, 911.4804561400005, 911.9498427586481, 762.9542227466342, 896.7085697148453, 904.2449554621899, 905.1762895764822, 908.9910199678352, 665.5640555436197, 673.804596666966, 674.0866126398757, 674.912261406019, 676.3202981004059, 14611.561653150422, 14835.25823708821, 15006.62483437912, 15032.248387580577, 15368.077915325117, 14233.146011239256, 14521.128732276096, 14678.266086695729, 14699.338529766186, 14761.114333139938, 11342.033347855371, 11742.941285293518, 11771.64685059441, 11778.882211177865, 11906.226095303777, 3615.023943535257, 3635.1093981974323, 3699.1134521394283, 3744.6817020553285, 3851.1527463957887, 88270.11729882748, 100372.0, 101300.0, 101386.49306753493, 103465.4826725869, 7905.367570594339, 10574.629887953884, 10598.470076496144, 10671.946640266904, 10752.569897204181, 21234.78765212359, 21368.679469807965, 21412.464688382603, 21619.027143778567, 21740.347789566338, 7489.887651685229, 7550.471466997367, 7584.734534291273, 7637.6563054661565, 7722.498037627649, 3595.2449985503335, 4166.583341665809, 4167.0, 4188.937165942513, 4190.895227619334, 2912.6504819421807, 3358.5130156127225, 3402.727781777452, 3426.8629254830025, 3435.381631306339, 629.8866204083309, 634.5970308853911, 657.6317262333109, 658.1937127019363, 661.1504217081027, 613.6686189457732, 647.1102234427661, 657.063684249942, 665.896785998171, 679.8245614035009, 9292.95353523228, 9850.901490985141, 9884.752881178028, 9902.059304366074, 9984.850227246598, 587.9735411906474, 624.2259598098416, 626.7712285016028, 646.4549726154495, 673.3233100733829, 4642.141203877293, 4690.663160999167, 4734.597559207506, 4741.5495527924795, 4757.119932812371, 71752.64123679348, 74749.25250747532, 78535.60732196417, 81691.0, 88752.55623721969, 72951.63524182345, 75407.86888196682, 76093.0, 78156.0, 79113.20886791058, 69976.6501167491, 70274.64862675757, 72359.0, 72561.2743872565, 74029.5194096115, 10240.385576865412, 10633.468326583485, 10725.839112413163, 10837.729056773644, 10874.510647020745, 43210.78394608007, 44069.11861762811, 44091.77954110209, 44352.11295774002, 44873.10253794971, 45605.77197113993, 54551.6362090935, 55621.721891391906, 56945.29164125083, 58793.0, 12586.559470418491, 12675.17611355259, 12721.982241420848, 13242.0, 13482.19106853592, 12524.998000159783, 14070.859291406954, 14302.113512465632, 14462.493812716504, 14528.709425811636, 13090.280034597808, 13098.672533186365, 13353.0, 14011.859881401055, 14031.0, 12930.353482326034, 13201.933990329986, 13544.322783860966, 13567.118137321042, 13942.930285348508, 13115.93442032822, 13270.933645331712, 13296.0, 13303.534376296782, 13319.866801331862, 9333.439993600407, 9751.853722194315, 10074.54664540112, 10239.795204096024, 10612.628558000433, 10017.098461138532, 10057.748556285858, 10061.195104391485, 10064.44645544502, 10077.596896124367], "value": 7192.5071134574055, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 117.0, 116.0, 115.0, 116.0, 116.0, 117.0, 116.0, 118.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 143.0, 112.0, 145.0, 113.0, 146.0, 143.0, 116.0, 133.0, 114.0], "value": 131.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 198.0, 196.0, 197.0, 236.0, 293.0, 197.0, 286.0, 277.0, 199.0], "value": 228.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 84.0, 59.0, 51.0, 75.0, 86.0, 98.0, 85.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 82.0, 70.0, 74.0, 87.0, 115.0, 102.0, 81.0, 82.0], "value": 85.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 89.0, 119.0, 136.0, 86.0, 92.0, 86.0, 90.0, 87.0], "value": 105.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 117.0, 156.0, 110.0, 96.0, 97.0, 124.0, 114.0, 98.0, 97.0], "value": 110.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 94.0, 91.0, 95.0, 90.0, 94.0, 106.0, 145.0, 113.0], "value": 101.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 58.0, 62.0, 63.0, 64.0, 62.0, 64.0, 61.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 76.0, 77.0, 74.0, 71.0, 81.0, 74.0, 61.0, 86.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 86.0, 85.0, 85.0, 86.0, 84.0, 110.0, 103.0, 107.0], "value": 96.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 145.0, 129.0, 155.0, 152.0, 163.0, 144.0, 156.0, 202.0, 137.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 189.0, 172.0, 170.0, 167.0, 168.0, 168.0, 171.0, 213.0, 235.0], "value": 185.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 92.0, 89.0, 63.0, 85.0, 87.0, 86.0, 92.0, 75.0, 69.0], "value": 79.8, "unit": "score"}]}]} 09:52:01 INFO - Return code: 0 09:52:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:52:01 ERROR - # TBPL SUCCESS # 09:52:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:52:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:52:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:52:01 INFO - 2017-02-23 09:52:01.596 screenresolution[2016:18503] starting screenresolution argv=screenresolution get 09:52:01 INFO - 2017-02-23 09:52:01.599 screenresolution[2016:18503] Display 0: 1600x1200x32@60 09:52:01 INFO - 2017-02-23 09:52:01.605 screenresolution[2017:18506] starting screenresolution argv=screenresolution list 09:52:01 INFO - Available Modes on Display 0 09:52:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:52:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:52:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:52:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:52:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:52:01 INFO - Intel Iris: 09:52:01 INFO - Chipset Model: Intel Iris 09:52:01 INFO - Type: GPU 09:52:01 INFO - Bus: Built-In 09:52:01 INFO - VRAM (Dynamic, Max): 1536 MB 09:52:01 INFO - Vendor: Intel (0x8086) 09:52:01 INFO - Device ID: 0x0a2e 09:52:01 INFO - Revision ID: 0x0009 09:52:01 INFO - Displays: 09:52:01 INFO - Display: 09:52:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:52:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:52:01 INFO - Display Serial Number: 1600x1200 60 09:52:01 INFO - Main Display: Yes 09:52:01 INFO - Mirror: Off 09:52:01 INFO - Online: Yes 09:52:01 INFO - Rotation: Supported 09:52:01 INFO - Return code: 0 09:52:01 INFO - Running post-action listener: _resource_record_post_action 09:52:01 INFO - [mozharness: 2017-02-23 17:52:01.841017Z] Finished run-tests step (success) 09:52:01 INFO - Running post-run listener: _resource_record_post_run 09:52:01 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 2985984; Write bytes: 510060032; Read time: 17; Write time: 1560 09:52:01 INFO - TinderboxPrint: CPU usage
54.3% 09:52:01 INFO - TinderboxPrint: I/O read bytes / time
2,985,984 / 17 09:52:01 INFO - TinderboxPrint: I/O write bytes / time
510,060,032 / 1,560 09:52:01 INFO - TinderboxPrint: CPU idle
2,189.7 (45.7%) 09:52:01 INFO - TinderboxPrint: CPU system
965.1 (20.1%) 09:52:01 INFO - TinderboxPrint: CPU user
1,639.0 (34.2%) 09:52:01 INFO - TinderboxPrint: Swap in / out
210,935,808 / 0 09:52:01 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201155072; Write bytes: 200791552; Read time: 15454; Write time: 443 09:52:01 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 2985984; Write bytes: 298577920; Read time: 17; Write time: 1080 09:52:02 INFO - Running post-run listener: _upload_blobber_files 09:52:02 INFO - Blob upload gear active. 09:52:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:52:02 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 09:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:52:02 INFO - (blobuploader) - INFO - Open directory for files ... 09:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:52:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:03 INFO - (blobuploader) - INFO - Done attempting. 09:52:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:52:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:52:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:04 INFO - (blobuploader) - INFO - Done attempting. 09:52:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:52:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:52:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:05 INFO - (blobuploader) - INFO - Done attempting. 09:52:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:52:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:52:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:08 INFO - (blobuploader) - INFO - Done attempting. 09:52:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:52:08 INFO - Return code: 0 09:52:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:52:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:52:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49a9a438f88f05c6c5d10d42c0c07b0b294cf63fd5d9ac8cf62ef63981d8c58feeaf2e17442dde257e7f90ae77ceb88233fabb3a4ebc91d446aee7ed21ba10ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad7f47c53c80a6638dcbc9930325752184c9f6bfe4256044e91285b9c14f42f8601b1e088eed162e2d483dc3d48e396d00f84f4e5f48b6c460903e3a10f88c4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7eb2577512cbbba0db184b80b0889d4c24fbd658895f46de898d57e3b9f50aa3de583d951381fc100e01ba96a85f245e4e2fad26aaae0478c8fa0438cfcecff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d030e49051de9c38dd6e68d8469e32d423ef160256bda63ebc6f79d96fec9611e3e94b761ea34e94aa07a2f736b2c1e05a72104d34d12fd590a317e1da69b5c"} 09:52:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:52:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:52:08 INFO - Contents: 09:52:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49a9a438f88f05c6c5d10d42c0c07b0b294cf63fd5d9ac8cf62ef63981d8c58feeaf2e17442dde257e7f90ae77ceb88233fabb3a4ebc91d446aee7ed21ba10ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad7f47c53c80a6638dcbc9930325752184c9f6bfe4256044e91285b9c14f42f8601b1e088eed162e2d483dc3d48e396d00f84f4e5f48b6c460903e3a10f88c4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7eb2577512cbbba0db184b80b0889d4c24fbd658895f46de898d57e3b9f50aa3de583d951381fc100e01ba96a85f245e4e2fad26aaae0478c8fa0438cfcecff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d030e49051de9c38dd6e68d8469e32d423ef160256bda63ebc6f79d96fec9611e3e94b761ea34e94aa07a2f736b2c1e05a72104d34d12fd590a317e1da69b5c"} 09:52:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:52:08 INFO - Copying logs to upload dir... 09:52:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:52:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.482882 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-23 09:52:08.563718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 09:52:08.566993) ========= 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.PFYllRUKET/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.Jo052fTBG7/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49a9a438f88f05c6c5d10d42c0c07b0b294cf63fd5d9ac8cf62ef63981d8c58feeaf2e17442dde257e7f90ae77ceb88233fabb3a4ebc91d446aee7ed21ba10ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad7f47c53c80a6638dcbc9930325752184c9f6bfe4256044e91285b9c14f42f8601b1e088eed162e2d483dc3d48e396d00f84f4e5f48b6c460903e3a10f88c4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7eb2577512cbbba0db184b80b0889d4c24fbd658895f46de898d57e3b9f50aa3de583d951381fc100e01ba96a85f245e4e2fad26aaae0478c8fa0438cfcecff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d030e49051de9c38dd6e68d8469e32d423ef160256bda63ebc6f79d96fec9611e3e94b761ea34e94aa07a2f736b2c1e05a72104d34d12fd590a317e1da69b5c"} build_url:https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011047 build_url: 'https://queue.taskcluster.net/v1/task/WClRpQzaSxqXCoo5USGRYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49a9a438f88f05c6c5d10d42c0c07b0b294cf63fd5d9ac8cf62ef63981d8c58feeaf2e17442dde257e7f90ae77ceb88233fabb3a4ebc91d446aee7ed21ba10ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad7f47c53c80a6638dcbc9930325752184c9f6bfe4256044e91285b9c14f42f8601b1e088eed162e2d483dc3d48e396d00f84f4e5f48b6c460903e3a10f88c4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7eb2577512cbbba0db184b80b0889d4c24fbd658895f46de898d57e3b9f50aa3de583d951381fc100e01ba96a85f245e4e2fad26aaae0478c8fa0438cfcecff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d030e49051de9c38dd6e68d8469e32d423ef160256bda63ebc6f79d96fec9611e3e94b761ea34e94aa07a2f736b2c1e05a72104d34d12fd590a317e1da69b5c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 09:52:08.600872) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:52:08.601202) ========= 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.PFYllRUKET/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.Jo052fTBG7/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005214 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 09:52:08.649697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 09:52:08.650010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 09:52:08.650349) ========= ========= Total master_lag: 0.18 =========