builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0023 starttime: 1488126910.65 results: success (0) buildid: 20170226071908 builduid: 2c205e6d02d24fbfad1a8a48dc5a15d0 revision: 4d497454ce0c0e1c6f3339c1e1a17528e894d7ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:10.646261) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:10.647309) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:10.647728) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:10.677141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:10.677536) ========= 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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-26 08:35:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.0M=0.001s 2017-02-26 08:35:11 (21.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.460645 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:11.162640) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:11.162990) ========= 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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.027427 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:11.223575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:11.223913) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4d497454ce0c0e1c6f3339c1e1a17528e894d7ce --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 4d497454ce0c0e1c6f3339c1e1a17528e894d7ce --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LzoHHAVDC0/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.aXlpx4lkiV/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-26 08:35:11,322 truncating revision to first 12 chars 2017-02-26 08:35:11,322 Setting DEBUG logging. 2017-02-26 08:35:11,322 attempt 1/10 2017-02-26 08:35:11,322 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4d497454ce0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-26 08:35:11,981 unpacking tar archive at: mozilla-aurora-4d497454ce0c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.927187 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:12.179193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:12.179484) ========= script_repo_revision: 4d497454ce0c0e1c6f3339c1e1a17528e894d7ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:12.179832) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:12.180087) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-26 08:35:12.215938) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-26 08:35:12.216205) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LzoHHAVDC0/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.aXlpx4lkiV/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:35:12 INFO - MultiFileLogger online at 20170226 08:35:12 in /builds/slave/test 08:35:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:35:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:35:12 INFO - {'append_to_log': False, 08:35:12 INFO - 'base_work_dir': '/builds/slave/test', 08:35:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:35:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:35:12 INFO - 'branch': 'Mozilla-Aurora', 08:35:12 INFO - 'buildbot_json_path': 'buildprops.json', 08:35:12 INFO - 'config_files': ('talos/mac_config.py',), 08:35:12 INFO - 'default_actions': ('clobber', 08:35:12 INFO - 'read-buildbot-config', 08:35:12 INFO - 'download-and-extract', 08:35:12 INFO - 'populate-webroot', 08:35:12 INFO - 'create-virtualenv', 08:35:12 INFO - 'install', 08:35:12 INFO - 'run-tests'), 08:35:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:35:12 INFO - 'download_minidump_stackwalk': True, 08:35:12 INFO - 'download_symbols': 'ondemand', 08:35:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:35:12 INFO - 'tooltool.py': '/tools/tooltool.py', 08:35:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:35:12 INFO - '/tools/misc-python/virtualenv.py')}, 08:35:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:35:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:35:12 INFO - 'installer_path': 'installer.exe', 08:35:12 INFO - 'log_level': 'info', 08:35:12 INFO - 'log_name': 'talos', 08:35:12 INFO - 'log_to_console': True, 08:35:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:35:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:35:12 INFO - 'opt_config_files': (), 08:35:12 INFO - 'pip_index': False, 08:35:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:35:12 INFO - 'cmd': ('bash', 08:35:12 INFO - '-c', 08:35:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:35:12 INFO - 'enabled': True, 08:35:12 INFO - 'halt_on_failure': False, 08:35:12 INFO - 'name': 'check_screen_resolution'},), 08:35:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:35:12 INFO - 'cmd': ('bash', 08:35:12 INFO - '-c', 08:35:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:35:12 INFO - 'enabled': True, 08:35:12 INFO - 'halt_on_failure': False, 08:35:12 INFO - 'name': 'check_screen_resolution'},), 08:35:12 INFO - 'run_cmd_checks_enabled': True, 08:35:12 INFO - 'sps_profile': False, 08:35:12 INFO - 'sps_profile_interval': 0, 08:35:12 INFO - 'suite': 'dromaeojs', 08:35:12 INFO - 'system_bits': '32', 08:35:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:35:12 INFO - 'title': 't-yosemite-r7-0023', 08:35:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:35:12 INFO - 'use_talos_json': True, 08:35:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:35:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:35:12 INFO - 'work_dir': 'build'} 08:35:12 INFO - [mozharness: 2017-02-26 16:35:12.430613Z] Running clobber step. 08:35:12 INFO - Running pre-action listener: _resource_record_pre_action 08:35:12 INFO - Running main action method: clobber 08:35:12 INFO - rmtree: /builds/slave/test/build 08:35:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:35:14 INFO - Running post-action listener: _resource_record_post_action 08:35:14 INFO - [mozharness: 2017-02-26 16:35:14.929011Z] Finished clobber step (success) 08:35:14 INFO - [mozharness: 2017-02-26 16:35:14.929145Z] Running read-buildbot-config step. 08:35:14 INFO - Running pre-action listener: _resource_record_pre_action 08:35:14 INFO - Running main action method: read_buildbot_config 08:35:14 INFO - Using buildbot properties: 08:35:14 INFO - { 08:35:14 INFO - "project": "", 08:35:14 INFO - "product": "firefox", 08:35:14 INFO - "script_repo_revision": "production", 08:35:14 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:35:14 INFO - "repository": "", 08:35:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:35:14 INFO - "buildid": "20170226071908", 08:35:14 INFO - "pgo_build": "False", 08:35:14 INFO - "basedir": "/builds/slave/test", 08:35:14 INFO - "buildnumber": 10, 08:35:14 INFO - "slavename": "t-yosemite-r7-0023", 08:35:14 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:35:14 INFO - "platform": "yosemite_r7", 08:35:14 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:35:14 INFO - "branch": "mozilla-aurora", 08:35:14 INFO - "repo_path": "releases/mozilla-aurora", 08:35:14 INFO - "revision": "4d497454ce0c0e1c6f3339c1e1a17528e894d7ce", 08:35:14 INFO - "stage_platform": "macosx64", 08:35:14 INFO - "builduid": "2c205e6d02d24fbfad1a8a48dc5a15d0", 08:35:14 INFO - "slavebuilddir": "test" 08:35:14 INFO - } 08:35:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:35:14 INFO - Running post-action listener: _resource_record_post_action 08:35:14 INFO - [mozharness: 2017-02-26 16:35:14.932564Z] Finished read-buildbot-config step (success) 08:35:14 INFO - [mozharness: 2017-02-26 16:35:14.932687Z] Running download-and-extract step. 08:35:14 INFO - Running pre-action listener: _resource_record_pre_action 08:35:14 INFO - Running main action method: download_and_extract 08:35:14 INFO - mkdir: /builds/slave/test/build/tests 08:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:14 INFO - trying https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:35:14 INFO - Downloading https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/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 08:35:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/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 08:35:15 INFO - Downloaded 1199 bytes. 08:35:15 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:35:15 INFO - Using the following test package requirements: 08:35:15 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:35:15 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:35:15 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:35:15 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:35:15 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:35:15 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:35:15 INFO - u'jsshell-mac.zip'], 08:35:15 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:35:15 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:35:15 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:35:15 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:35:15 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:35:15 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:35:15 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:35:15 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:35:15 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:35:15 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:35:15 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:35:15 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:35:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:35:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:35:15 INFO - Fetch https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:35:16 INFO - Expected file size: 16357785 08:35:16 INFO - Obtained file size: 16357785 08:35:23 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 08:35:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:35:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:35:23 INFO - Fetch https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:35:24 INFO - Expected file size: 16357785 08:35:24 INFO - Obtained file size: 16357785 08:35:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:35:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:35:30 INFO - Fetch https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:35:31 INFO - Expected file size: 14403472 08:35:31 INFO - Obtained file size: 14403472 08:35:31 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')]} 08:35:31 INFO - trying https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:35:31 INFO - Downloading https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:35:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/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 08:35:33 INFO - Downloaded 73928180 bytes. 08:35:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:35:33 INFO - mkdir: /builds/slave/test/properties 08:35:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:35:33 INFO - Writing to file /builds/slave/test/properties/build_url 08:35:33 INFO - Contents: 08:35:33 INFO - build_url:https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:35:34 INFO - Running post-action listener: _resource_record_post_action 08:35:34 INFO - Running post-action listener: set_extra_try_arguments 08:35:34 INFO - [mozharness: 2017-02-26 16:35:34.635724Z] Finished download-and-extract step (success) 08:35:34 INFO - [mozharness: 2017-02-26 16:35:34.635858Z] Running populate-webroot step. 08:35:34 INFO - Running pre-action listener: _resource_record_pre_action 08:35:34 INFO - Running main action method: populate_webroot 08:35:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:35:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:35:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:35:34 INFO - '--tppagecycles', 08:35:34 INFO - '7'], 08:35:34 INFO - 'tests': ['tsvgm']}}, 08:35:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:35:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:35:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:35:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:35:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:35:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:35:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:35:34 INFO - 'talos_options': ['--disable-e10s'], 08:35:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:35:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:35:34 INFO - 'talos_options': ['--disable-e10s'], 08:35:34 INFO - 'tests': ['damp', 'tps']}, 08:35:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:35:34 INFO - 'tests': ['damp', 'tps']}, 08:35:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:35:34 INFO - 'tests': ['dromaeo_dom']}, 08:35:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:35:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:35:34 INFO - 'tests': ['basic_compositor_video']}, 08:35:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:35:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:35:34 INFO - 'tests': ['a11yr', 08:35:34 INFO - 'ts_paint', 08:35:34 INFO - 'tpaint', 08:35:34 INFO - 'sessionrestore', 08:35:34 INFO - 'sessionrestore_no_auto_restore', 08:35:34 INFO - 'tabpaint']}, 08:35:34 INFO - 'other-e10s': {'tests': ['a11yr', 08:35:34 INFO - 'ts_paint', 08:35:34 INFO - 'tpaint', 08:35:34 INFO - 'sessionrestore', 08:35:34 INFO - 'sessionrestore_no_auto_restore', 08:35:34 INFO - 'tabpaint']}, 08:35:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:35:34 INFO - 'ts_paint', 08:35:34 INFO - 'tpaint', 08:35:34 INFO - 'sessionrestore', 08:35:34 INFO - 'sessionrestore_no_auto_restore', 08:35:34 INFO - 'tabpaint']}, 08:35:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:35:34 INFO - 'ts_paint', 08:35:34 INFO - 'tpaint', 08:35:34 INFO - 'sessionrestore', 08:35:34 INFO - 'sessionrestore_no_auto_restore', 08:35:34 INFO - 'tabpaint']}, 08:35:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:35:34 INFO - 'tests': ['a11yr', 08:35:34 INFO - 'ts_paint', 08:35:34 INFO - 'tpaint', 08:35:34 INFO - 'sessionrestore', 08:35:34 INFO - 'sessionrestore_no_auto_restore', 08:35:34 INFO - 'tabpaint']}, 08:35:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:35:34 INFO - 'tests': ['a11yr', 08:35:34 INFO - 'ts_paint', 08:35:34 INFO - 'tpaint', 08:35:34 INFO - 'sessionrestore', 08:35:34 INFO - 'sessionrestore_no_auto_restore', 08:35:34 INFO - 'tabpaint']}, 08:35:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:35:34 INFO - 'tests': ['tsvgx', 08:35:34 INFO - 'tsvgr_opacity', 08:35:34 INFO - 'tart', 08:35:34 INFO - 'tscrollx', 08:35:34 INFO - 'cart', 08:35:34 INFO - 'tsvg_static']}, 08:35:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:35:34 INFO - 'tsvgr_opacity', 08:35:34 INFO - 'tart', 08:35:34 INFO - 'tscrollx', 08:35:34 INFO - 'cart', 08:35:34 INFO - 'tsvg_static']}, 08:35:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:35:34 INFO - 'talos_options': ['--disable-e10s'], 08:35:34 INFO - 'tests': ['tp5o']}, 08:35:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:35:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:35:34 INFO - 'talos_options': ['--disable-e10s', 08:35:34 INFO - '--xperf_path', 08:35:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:34 INFO - 'tests': ['tp5n']}, 08:35:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:35:34 INFO - 'talos_options': ['--xperf_path', 08:35:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:34 INFO - 'tests': ['tp5n']}}, 08:35:34 INFO - 'talos.zip': {'path': '', 08:35:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:35:34 INFO - Running post-action listener: _resource_record_post_action 08:35:34 INFO - [mozharness: 2017-02-26 16:35:34.654613Z] Finished populate-webroot step (success) 08:35:34 INFO - [mozharness: 2017-02-26 16:35:34.654740Z] Running create-virtualenv step. 08:35:34 INFO - Running pre-action listener: _resource_record_pre_action 08:35:34 INFO - Running main action method: create_virtualenv 08:35:34 INFO - Creating virtualenv /builds/slave/test/build/venv 08:35:34 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 08:35:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:35:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:35:34 INFO - Using real prefix '/tools/python27' 08:35:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:35:35 INFO - Installing distribute.............................................................................................................................................................................................done. 08:35:38 INFO - Installing pip.................done. 08:35:38 INFO - Return code: 0 08:35:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:35:38 INFO - Reading from file tmpfile_stdout 08:35:38 INFO - Output received: 08:35:38 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) 08:35:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:35: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')]} 08:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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')]} 08:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101264b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101267768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8cb3e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101042d30>, '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 0x100f69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101037be8>, '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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:35: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', 'pip>=1.5'] in /builds/slave/test/build 08:35: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 pip>=1.5 08:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LzoHHAVDC0/Render', 08:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:38 INFO - 'HOME': '/Users/cltbld', 08:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:38 INFO - 'LOGNAME': 'cltbld', 08:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:38 INFO - 'MOZ_NO_REMOTE': '1', 08:35:38 INFO - 'NO_EM_RESTART': '1', 08:35:38 INFO - 'PAGER': '/bin/cat', 08:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:38 INFO - 'PWD': '/builds/slave/test', 08:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:38 INFO - 'SHELL': '/bin/bash', 08:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aXlpx4lkiV/Listeners', 08:35:38 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:38 INFO - 'USER': 'cltbld', 08:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:38 INFO - 'XPC_FLAGS': '0x0', 08:35:38 INFO - 'XPC_SERVICE_NAME': '0', 08:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:38 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 08:35:38 INFO - Cleaning up... 08:35:38 INFO - Return code: 0 08:35:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:35: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')]} 08:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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')]} 08:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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', '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 0x101264b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101267768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8cb3e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101042d30>, '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 0x100f69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101037be8>, '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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:35: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:35: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 psutil>=3.1.1 08:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LzoHHAVDC0/Render', 08:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:38 INFO - 'HOME': '/Users/cltbld', 08:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:38 INFO - 'LOGNAME': 'cltbld', 08:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:38 INFO - 'MOZ_NO_REMOTE': '1', 08:35:38 INFO - 'NO_EM_RESTART': '1', 08:35:38 INFO - 'PAGER': '/bin/cat', 08:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:38 INFO - 'PWD': '/builds/slave/test', 08:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:38 INFO - 'SHELL': '/bin/bash', 08:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aXlpx4lkiV/Listeners', 08:35:38 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:38 INFO - 'USER': 'cltbld', 08:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:38 INFO - 'XPC_FLAGS': '0x0', 08:35:38 INFO - 'XPC_SERVICE_NAME': '0', 08:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:39 INFO - Downloading/unpacking psutil>=3.1.1 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:35:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:42 INFO - Installing collected packages: psutil 08:35:42 INFO - Running setup.py install for psutil 08:35:43 INFO - building 'psutil._psutil_osx' extension 08:35:43 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 08:35:43 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 08:35:43 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 08:35:43 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 08:35:43 INFO - building 'psutil._psutil_posix' extension 08:35:43 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 08:35:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:35:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:35:43 INFO - ^ 08:35:44 INFO - 1 warning generated. 08:35:44 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 08:35:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:44 INFO - Successfully installed psutil 08:35:44 INFO - Cleaning up... 08:35:44 INFO - Return code: 0 08:35:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:35:44 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')]} 08:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:44 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')]} 08:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:44 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 0x101264b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101267768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8cb3e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101042d30>, '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 0x100f69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101037be8>, '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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:35:44 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 08:35:44 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 08:35:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LzoHHAVDC0/Render', 08:35:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:44 INFO - 'HOME': '/Users/cltbld', 08:35:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:44 INFO - 'LOGNAME': 'cltbld', 08:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:44 INFO - 'MOZ_NO_REMOTE': '1', 08:35:44 INFO - 'NO_EM_RESTART': '1', 08:35:44 INFO - 'PAGER': '/bin/cat', 08:35:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:44 INFO - 'PWD': '/builds/slave/test', 08:35:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:44 INFO - 'SHELL': '/bin/bash', 08:35:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aXlpx4lkiV/Listeners', 08:35:44 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:35:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:44 INFO - 'USER': 'cltbld', 08:35:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:44 INFO - 'XPC_FLAGS': '0x0', 08:35:44 INFO - 'XPC_SERVICE_NAME': '0', 08:35:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:35:44 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 08:35:44 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 08:35:44 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 08:35:44 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 08:35:44 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 08:35:44 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 08:35:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:35:47 INFO - Installing collected packages: mozsystemmonitor 08:35:47 INFO - Running setup.py install for mozsystemmonitor 08:35:47 INFO - Successfully installed mozsystemmonitor 08:35:47 INFO - Cleaning up... 08:35:47 INFO - Return code: 0 08:35:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:35:47 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')]} 08:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:47 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')]} 08:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:47 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 0x101264b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101267768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8cb3e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101042d30>, '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 0x100f69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101037be8>, '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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:35:47 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 08:35:47 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 08:35:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LzoHHAVDC0/Render', 08:35:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:47 INFO - 'HOME': '/Users/cltbld', 08:35:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:47 INFO - 'LOGNAME': 'cltbld', 08:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:47 INFO - 'MOZ_NO_REMOTE': '1', 08:35:47 INFO - 'NO_EM_RESTART': '1', 08:35:47 INFO - 'PAGER': '/bin/cat', 08:35:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:47 INFO - 'PWD': '/builds/slave/test', 08:35:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:47 INFO - 'SHELL': '/bin/bash', 08:35:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aXlpx4lkiV/Listeners', 08:35:47 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:35:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:47 INFO - 'USER': 'cltbld', 08:35:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:47 INFO - 'XPC_FLAGS': '0x0', 08:35:47 INFO - 'XPC_SERVICE_NAME': '0', 08:35:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:47 INFO - Downloading/unpacking jsonschema==2.5.1 08:35:47 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 08:35:47 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 08:35:47 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 08:35:47 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 08:35:47 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 08:35:47 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 08:35:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:35:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:35:50 INFO - warning: no files found matching '*.txt' 08:35:50 INFO - no previously-included directories found matching 'build' 08:35:50 INFO - no previously-included directories found matching 'dist' 08:35:50 INFO - no previously-included directories found matching '.git*' 08:35:50 INFO - Installing collected packages: jsonschema, functools32 08:35:50 INFO - Running setup.py install for functools32 08:35:50 INFO - warning: no files found matching '*.txt' 08:35:50 INFO - no previously-included directories found matching 'build' 08:35:50 INFO - no previously-included directories found matching 'dist' 08:35:50 INFO - no previously-included directories found matching '.git*' 08:35:50 INFO - Successfully installed jsonschema functools32 08:35:50 INFO - Cleaning up... 08:35:50 INFO - Return code: 0 08:35:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:50 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 0x101264b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101267768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8cb3e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101042d30>, '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 0x100f69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101037be8>, '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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:35:50 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 08:35:50 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 08:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LzoHHAVDC0/Render', 08:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:51 INFO - 'HOME': '/Users/cltbld', 08:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:51 INFO - 'LOGNAME': 'cltbld', 08:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:51 INFO - 'MOZ_NO_REMOTE': '1', 08:35:51 INFO - 'NO_EM_RESTART': '1', 08:35:51 INFO - 'PAGER': '/bin/cat', 08:35:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:51 INFO - 'PWD': '/builds/slave/test', 08:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:51 INFO - 'SHELL': '/bin/bash', 08:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aXlpx4lkiV/Listeners', 08:35:51 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:51 INFO - 'USER': 'cltbld', 08:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:51 INFO - 'XPC_FLAGS': '0x0', 08:35:51 INFO - 'XPC_SERVICE_NAME': '0', 08:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:35:51 INFO - Cleaning up... 08:35:51 INFO - Return code: 0 08:35:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:35: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')]} 08:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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')]} 08:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:51 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 0x101264b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101267768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8cb3e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101042d30>, '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 0x100f69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101037be8>, '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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:35:51 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 08:35:51 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 08:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LzoHHAVDC0/Render', 08:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:51 INFO - 'HOME': '/Users/cltbld', 08:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:51 INFO - 'LOGNAME': 'cltbld', 08:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:51 INFO - 'MOZ_NO_REMOTE': '1', 08:35:51 INFO - 'NO_EM_RESTART': '1', 08:35:51 INFO - 'PAGER': '/bin/cat', 08:35:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:51 INFO - 'PWD': '/builds/slave/test', 08:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:51 INFO - 'SHELL': '/bin/bash', 08:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aXlpx4lkiV/Listeners', 08:35:51 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:51 INFO - 'USER': 'cltbld', 08:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:51 INFO - 'XPC_FLAGS': '0x0', 08:35:51 INFO - 'XPC_SERVICE_NAME': '0', 08:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:35:51 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 08:35:51 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 08:35:51 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 08:35:51 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 08:35:51 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 08:35:51 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 08:35:54 INFO - Downloading blobuploader-1.2.4.tar.gz 08:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:35:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:35:54 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 08:35:54 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 08:35:54 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 08:35:54 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 08:35:54 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 08:35:54 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 08:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:35:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:35:54 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 08:35:54 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 08:35:54 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 08:35:54 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 08:35:54 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 08:35:54 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 08:35:55 INFO - Downloading docopt-0.6.1.tar.gz 08:35:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:35:55 INFO - Installing collected packages: blobuploader, requests, docopt 08:35:55 INFO - Running setup.py install for blobuploader 08:35:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:35:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:35:55 INFO - Running setup.py install for requests 08:35:56 INFO - Running setup.py install for docopt 08:35:56 INFO - Successfully installed blobuploader requests docopt 08:35:56 INFO - Cleaning up... 08:35:56 INFO - Return code: 0 08:35:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:56 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 0x101264b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101267768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8cb3e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101042d30>, '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 0x100f69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101037be8>, '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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:35:56 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 08:35:56 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 08:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LzoHHAVDC0/Render', 08:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:56 INFO - 'HOME': '/Users/cltbld', 08:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:56 INFO - 'LOGNAME': 'cltbld', 08:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:56 INFO - 'MOZ_NO_REMOTE': '1', 08:35:56 INFO - 'NO_EM_RESTART': '1', 08:35:56 INFO - 'PAGER': '/bin/cat', 08:35:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:56 INFO - 'PWD': '/builds/slave/test', 08:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:56 INFO - 'SHELL': '/bin/bash', 08:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aXlpx4lkiV/Listeners', 08:35:56 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:56 INFO - 'USER': 'cltbld', 08:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:56 INFO - 'XPC_FLAGS': '0x0', 08:35:56 INFO - 'XPC_SERVICE_NAME': '0', 08:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-1gmowt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-1i1HBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-2i2icD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-MYycMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Wh700X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-OewlPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-GzyRZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-NFbfBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-BU9Wla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-4vupA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-3FzOUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-t_s8RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-aNzD2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:57 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-39bDgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:58 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-tOY6cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:58 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-1vsreL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:58 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-O7NzwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:35:58 INFO - Running setup.py install for manifestparser 08:35:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:35:58 INFO - Running setup.py install for mozcrash 08:35:58 INFO - Running setup.py install for mozdebug 08:35:58 INFO - Running setup.py install for mozdevice 08:35:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:35:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:35:58 INFO - Running setup.py install for mozfile 08:35:59 INFO - Running setup.py install for mozhttpd 08:35:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:35:59 INFO - Running setup.py install for mozinfo 08:35:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:35:59 INFO - Running setup.py install for mozInstall 08:35:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:35:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:35:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:35:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:35:59 INFO - Running setup.py install for mozleak 08:35:59 INFO - Running setup.py install for mozlog 08:35:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:35:59 INFO - Running setup.py install for moznetwork 08:35:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:35:59 INFO - Running setup.py install for mozprocess 08:36:00 INFO - Running setup.py install for mozprofile 08:36:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:36:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:36:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:36:00 INFO - Running setup.py install for mozrunner 08:36:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:36:00 INFO - Running setup.py install for mozscreenshot 08:36:00 INFO - Running setup.py install for moztest 08:36:00 INFO - Running setup.py install for mozversion 08:36:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:36:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:36:00 INFO - Cleaning up... 08:36:00 INFO - Return code: 0 08:36:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:00 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')]} 08:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:00 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')]} 08:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:00 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 0x101264b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101267768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8cb3e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101042d30>, '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 0x100f69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101037be8>, '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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:36:00 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 08:36:00 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 08:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LzoHHAVDC0/Render', 08:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:00 INFO - 'HOME': '/Users/cltbld', 08:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:00 INFO - 'LOGNAME': 'cltbld', 08:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:00 INFO - 'MOZ_NO_REMOTE': '1', 08:36:00 INFO - 'NO_EM_RESTART': '1', 08:36:00 INFO - 'PAGER': '/bin/cat', 08:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:00 INFO - 'PWD': '/builds/slave/test', 08:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:00 INFO - 'SHELL': '/bin/bash', 08:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aXlpx4lkiV/Listeners', 08:36:00 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:00 INFO - 'USER': 'cltbld', 08:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:00 INFO - 'XPC_FLAGS': '0x0', 08:36:00 INFO - 'XPC_SERVICE_NAME': '0', 08:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-jmuvpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:01 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)) 08:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-8in4qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:01 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)) 08:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-mazFPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:01 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)) 08:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-09G9fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:01 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)) 08:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-MIouv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:01 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)) 08:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-gnFCIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:01 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)) 08:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-pjQ5WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:01 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)) 08:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Fw0D_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:02 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)) 08:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-rULgsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:02 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)) 08:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-UsZbh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:02 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)) 08:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-YBxw4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:02 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)) 08:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-8ZIPfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:02 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)) 08:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ralyXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:02 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)) 08:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-URxPq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:02 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)) 08:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-bjogh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:02 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)) 08:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-h5Ynrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:02 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)) 08:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:02 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-wUwu9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:02 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)) 08:36:02 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)) 08:36:02 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)) 08:36:02 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)) 08:36:02 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)) 08:36:02 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)) 08:36:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:36:03 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 08:36:03 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 08:36:03 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 08:36:03 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 08:36:03 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 08:36:03 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 08:36:05 INFO - Downloading blessings-1.6.tar.gz 08:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:36:05 INFO - Installing collected packages: blessings 08:36:05 INFO - Running setup.py install for blessings 08:36:05 INFO - Successfully installed blessings 08:36:05 INFO - Cleaning up... 08:36:06 INFO - Return code: 0 08:36:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:36:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:06 INFO - Reading from file tmpfile_stdout 08:36:06 INFO - Current package versions: 08:36:06 INFO - blessings == 1.6 08:36:06 INFO - blobuploader == 1.2.4 08:36:06 INFO - docopt == 0.6.1 08:36:06 INFO - functools32 == 3.2.3-2 08:36:06 INFO - jsonschema == 2.5.1 08:36:06 INFO - manifestparser == 1.1 08:36:06 INFO - mozInstall == 1.12 08:36:06 INFO - mozcrash == 1.0 08:36:06 INFO - mozdebug == 0.1 08:36:06 INFO - mozdevice == 0.49 08:36:06 INFO - mozfile == 1.2 08:36:06 INFO - mozhttpd == 0.7 08:36:06 INFO - mozinfo == 0.9 08:36:06 INFO - mozleak == 0.1 08:36:06 INFO - mozlog == 3.4 08:36:06 INFO - moznetwork == 0.27 08:36:06 INFO - mozprocess == 0.24 08:36:06 INFO - mozprofile == 0.28 08:36:06 INFO - mozrunner == 6.13 08:36:06 INFO - mozscreenshot == 0.1 08:36:06 INFO - mozsystemmonitor == 0.3 08:36:06 INFO - moztest == 0.8 08:36:06 INFO - mozversion == 1.4 08:36:06 INFO - psutil == 3.1.1 08:36:06 INFO - requests == 1.2.3 08:36:06 INFO - wsgiref == 0.1.2 08:36:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:06 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 0x101264b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101267768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8cb3e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101042d30>, '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 0x100f69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101037be8>, '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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:36:06 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 08:36:06 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 08:36:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LzoHHAVDC0/Render', 08:36:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:06 INFO - 'HOME': '/Users/cltbld', 08:36:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:06 INFO - 'LOGNAME': 'cltbld', 08:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:06 INFO - 'MOZ_NO_REMOTE': '1', 08:36:06 INFO - 'NO_EM_RESTART': '1', 08:36:06 INFO - 'PAGER': '/bin/cat', 08:36:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:06 INFO - 'PWD': '/builds/slave/test', 08:36:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:06 INFO - 'SHELL': '/bin/bash', 08:36:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aXlpx4lkiV/Listeners', 08:36:06 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:36:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:06 INFO - 'USER': 'cltbld', 08:36:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:06 INFO - 'XPC_FLAGS': '0x0', 08:36:06 INFO - 'XPC_SERVICE_NAME': '0', 08:36:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:06 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)) 08:36:06 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)) 08:36:06 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)) 08:36:06 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)) 08:36:06 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)) 08:36:06 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)) 08:36:06 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)) 08:36:06 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)) 08:36:06 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)) 08:36:06 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)) 08:36:06 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)) 08:36:06 INFO - Cleaning up... 08:36:06 INFO - Return code: 0 08:36:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101264b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101267768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8cb3e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101042d30>, '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 0x100f69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101037be8>, '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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 08:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:36:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LzoHHAVDC0/Render', 08:36:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:06 INFO - 'HOME': '/Users/cltbld', 08:36:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:06 INFO - 'LOGNAME': 'cltbld', 08:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:06 INFO - 'MOZ_NO_REMOTE': '1', 08:36:06 INFO - 'NO_EM_RESTART': '1', 08:36:06 INFO - 'PAGER': '/bin/cat', 08:36:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:06 INFO - 'PWD': '/builds/slave/test', 08:36:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:06 INFO - 'SHELL': '/bin/bash', 08:36:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aXlpx4lkiV/Listeners', 08:36:06 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:36:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:06 INFO - 'USER': 'cltbld', 08:36:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:06 INFO - 'XPC_FLAGS': '0x0', 08:36:06 INFO - 'XPC_SERVICE_NAME': '0', 08:36:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:36:06 INFO - Cleaning up... 08:36:06 INFO - Return code: 0 08:36:06 INFO - Running post-action listener: _resource_record_post_action 08:36:06 INFO - Running post-action listener: _start_resource_monitoring 08:36:06 INFO - Starting resource monitoring. 08:36:06 INFO - [mozharness: 2017-02-26 16:36:06.887577Z] Finished create-virtualenv step (success) 08:36:06 INFO - [mozharness: 2017-02-26 16:36:06.888534Z] Running install step. 08:36:06 INFO - Running pre-action listener: _resource_record_pre_action 08:36:06 INFO - Running main action method: install 08:36:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:07 INFO - Reading from file tmpfile_stdout 08:36:07 INFO - Detecting whether we're running mozinstall >=1.0... 08:36:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:36:07 INFO - Reading from file tmpfile_stdout 08:36:07 INFO - Output received: 08:36:07 INFO - Usage: mozinstall [options] installer 08:36:07 INFO - Options: 08:36:07 INFO - -h, --help show this help message and exit 08:36:07 INFO - -d DEST, --destination=DEST 08:36:07 INFO - Directory to install application into. [default: 08:36:07 INFO - "/builds/slave/test"] 08:36:07 INFO - --app=APP Application being installed. [default: firefox] 08:36:07 INFO - mkdir: /builds/slave/test/build/application 08:36:07 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'] 08:36:07 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 08:36:27 INFO - Reading from file tmpfile_stdout 08:36:27 INFO - Output received: 08:36:27 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:36:27 INFO - Running post-action listener: _resource_record_post_action 08:36:27 INFO - [mozharness: 2017-02-26 16:36:27.226059Z] Finished install step (success) 08:36:27 INFO - [mozharness: 2017-02-26 16:36:27.226211Z] Running run-tests step. 08:36:27 INFO - Running pre-action listener: _resource_record_pre_action 08:36:27 INFO - Running main action method: run_tests 08:36:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:36:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:36:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:36:27 INFO - 2017-02-26 08:36:27.240 screenresolution[1648:14939] starting screenresolution argv=screenresolution get 08:36:27 INFO - 2017-02-26 08:36:27.243 screenresolution[1648:14939] Display 0: 1600x1200x32@60 08:36:27 INFO - 2017-02-26 08:36:27.249 screenresolution[1649:14942] starting screenresolution argv=screenresolution list 08:36:27 INFO - Available Modes on Display 0 08:36:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:36:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:36:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:36:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:36:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:36:27 INFO - Intel Iris: 08:36:27 INFO - Chipset Model: Intel Iris 08:36:27 INFO - Type: GPU 08:36:27 INFO - Bus: Built-In 08:36:27 INFO - VRAM (Dynamic, Max): 1536 MB 08:36:27 INFO - Vendor: Intel (0x8086) 08:36:27 INFO - Device ID: 0x0a2e 08:36:27 INFO - Revision ID: 0x0009 08:36:27 INFO - Displays: 08:36:27 INFO - Display: 08:36:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:36:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:36:27 INFO - Display Serial Number: 1600x1200 60 08:36:27 INFO - Main Display: Yes 08:36:27 INFO - Mirror: Off 08:36:27 INFO - Online: Yes 08:36:27 INFO - Rotation: Supported 08:36:27 INFO - Return code: 0 08:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:36:27 INFO - Python 2.7.3 08:36:27 INFO - Return code: 0 08:36:27 INFO - grabbing minidump binary from tooltool 08:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:27 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 0x101042d30>, '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 0x100f69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101037be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:36:27 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 08:36:27 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 08:36:27 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 08:36:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:36:27 INFO - Return code: 0 08:36:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:36:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:36:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:36:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:36:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:36:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LzoHHAVDC0/Render', 08:36:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:27 INFO - 'HOME': '/Users/cltbld', 08:36:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:27 INFO - 'LOGNAME': 'cltbld', 08:36:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:36:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:27 INFO - 'MOZ_NO_REMOTE': '1', 08:36:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:36:27 INFO - 'NO_EM_RESTART': '1', 08:36:27 INFO - 'PAGER': '/bin/cat', 08:36:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:27 INFO - 'PWD': '/builds/slave/test', 08:36:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:36:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:27 INFO - 'SHELL': '/bin/bash', 08:36:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aXlpx4lkiV/Listeners', 08:36:27 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 08:36:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:27 INFO - 'USER': 'cltbld', 08:36:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:27 INFO - 'XPC_FLAGS': '0x0', 08:36:27 INFO - 'XPC_SERVICE_NAME': '0', 08:36:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:36:27 INFO - mozversion application_buildid: 20170226071908 08:36:27 INFO - mozversion application_changeset: 4d497454ce0c0e1c6f3339c1e1a17528e894d7ce 08:36:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:36:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:36:27 INFO - mozversion application_name: Firefox 08:36:27 INFO - mozversion application_remotingname: firefox-dev 08:36:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:36:27 INFO - mozversion application_vendor: Mozilla 08:36:27 INFO - mozversion application_version: 53.0a2 08:36:27 INFO - mozversion platform_buildid: 20170226071908 08:36:27 INFO - mozversion platform_changeset: 4d497454ce0c0e1c6f3339c1e1a17528e894d7ce 08:36:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:36:27 INFO - mozversion platform_version: 53.0a2 08:36:27 INFO - using testdate: 1488126987 08:36:27 INFO - actual date: 1488126987 08:36:27 INFO - starting webserver on 'localhost:49244' 08:36:27 INFO - SUITE-START | Running 2 tests 08:36:27 INFO - TEST-START | dromaeo_css 08:36:27 INFO - operating with platform_type : mac_ 08:36:27 INFO - Initialising browser for dromaeo_css test... 08:36:27 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpFz1vFE/profile http://localhost:49244/getInfo.html) 08:36:28 INFO - PROCESS | 1659 | 1488126988385 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 08:36:28 INFO - PROCESS | 1659 | 1488126988386 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 08:36:28 INFO - PROCESS | 1659 | 1488126988422 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 08:36:30 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 08:36:30 INFO - PROCESS | 1659 | colorDepth:24 08:36:30 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 08:36:30 INFO - PROCESS | 1659 | __metrics 08:36:30 INFO - PROCESS | 1659 | 1488126990220 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 08:36:30 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:36:30 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:36:30 INFO - TEST-INFO | 1659: exit 0 08:36:30 INFO - Browser initialized. 08:36:30 INFO - Running cycle 1/1 for dromaeo_css test... 08:36:30 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpFz1vFE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:31 INFO - PROCESS | 1662 | 1488126991302 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 08:36:31 INFO - PROCESS | 1662 | 1488126991302 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 08:36:43 INFO - PROCESS | 1662 | RSS: Main: 212889600 08:36:43 INFO - PROCESS | 1662 | 08:39:46 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 08:39:48 INFO - PROCESS | 1662 | RSS: Main: 300740608 08:39:48 INFO - PROCESS | 1662 | 08:41:31 INFO - PROCESS | 1662 | ************************* 08:41:31 INFO - PROCESS | 1662 | A coding exception was thrown and uncaught in a Task. 08:41:31 INFO - PROCESS | 1662 | 08:41:31 ERROR - PROCESS | 1662 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:41:31 INFO - PROCESS | 1662 | Full stack: 08:41:31 INFO - PROCESS | 1662 | ************************* 08:42:51 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 08:42:52 INFO - PROCESS | 1662 | RSS: Main: 371425280 08:42:52 INFO - PROCESS | 1662 | 08:45:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 08:45:55 INFO - PROCESS | 1662 | RSS: Main: 337178624 08:45:55 INFO - PROCESS | 1662 | 08:48:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 08:48:58 INFO - PROCESS | 1662 | RSS: Main: 326246400 08:48:58 INFO - PROCESS | 1662 | 08:52:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 08:52:02 INFO - PROCESS | 1662 | RSS: Main: 319373312 08:52:02 INFO - PROCESS | 1662 | 08:55:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 08:55:05 INFO - PROCESS | 1662 | RSS: Main: 586989568 08:55:05 INFO - PROCESS | 1662 | 08:55:05 INFO - PROCESS | 1662 | __start_tp_report 08:55:05 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 08:55:05 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 08:55:05 INFO - PROCESS | 1662 | |i|pagename|runs| 08:55:05 INFO - PROCESS | 1662 | |0;dojo.html;3163.525471179323;3354.4297469430185;3367.3433680432327;3406.386850366936;3418.1796368871464;5654.9151762723595;5683.886322273557;5714.599978001536;5730.997075511789;5756.769729210827;5721.227634269372;5734.569907256951;5810.535157187425;5815.447532484418;5819.127130930363;5226.817061402861;5236.727766800867;5256.947430525704;5312.17661262503;5324.65389749667;5137.614678899079;5143.3570803649545;5160.6903585784785;5330.786768529254;5333.839984800462;5216.66091704038;5224.39919409269;5228.294180285651;5288.762005709752;5339.385970613371;5313.814016509442;5314.92027619586;5317.574594032468;5322.361316641989;5329.227262046981;5117.385913690381;5166.07010738067;5238.8690282742855;5260.447652996419;5302.2046692996355;5594.496495315441;5608.747606357723;5653.265075540195;5653.9151912721345;5654.74553645087;6274.686265686697;6278.058291256302;6330.366963303679;6335.334789847046;6351.174347334863;6248.812535623939;6314.052892066181;6318.842028949267;6329.240491141092;6330.27201871786;5689.630174038674;5749.022666146765;5825.271841019872;5890.175375447441;5902.173695682608;6246.15676883624;6277.905831412532;6287.088372186007;6287.1198032275515;6324.146240257598;6199.256089269226;6199.5970261933735;6199.721012554446;6216.347283535254;6223.190985171898;6238.656873871981;6280.371962803683;6288.151099601587;6303.716332765037;6310.968445157745;6109.799438327889;6175.320714721377;6187.783427580013;6241.687915604201;6247.562670613013;6316.9368306317265;6331.968340158362;6346.555741098079;6348.365163483707;6350.555461117678;5036.370453693288;5037.546620804145;5053.1157047516535;5055.8988820223385;5062.240663900371;4386.605205531518;4446.599806017474;4447.844325448594;4477.753723545236;4491.887702807456;5723.914141287884;5757.625754325955;5770.538356931435;5781.4507621775865;5784.623999440023;6259.2488901332135;6297.2128483939505;6300.464460520907;6315.684215789284;6316.589421687576;5880.529557635379;5923.17075609415;5926.703664816742;5932.822015339547;5939.643621382731;5489.533389661844;5489.752961116759;5497.038018346773;5500.064988951808;5513.558915286768;6215.564910456315;6221.097940798469;6254.9687251563455;6281.623102613858;6358.841028974312;6248.250209974651;6295.653739044396;6318.178636777189;6334.746610135728;6342;6303.9684801575695;6305.464035557029;6312.747490100344;6322.8735425290315;6344;6132.846678832886;6133.334663918993;6209.975354066529;6211.409916057967;6227.252729672287;6212.378762123752;6216.160818289473;6221.720022599085;6250.312465628686;6255.374462553708;6134.35589263121;6156.569040167145;6159.5688301818445;6170.10533472653;6171.537134714825;5305.363356397257;6026.789062382795;6091.116788065794;6150.846228844314;6189.1025801257665;5867.354590995073;5964.493018093511;6001.099835024606;6038.033914573647;6118.785842495491;6153.094738520792;6205.906911396423;6213.099100630474;6219.813405597839;6221.253449585897;5850.356460789395;5890.4698577128265;5896.351401345934;5965.522758179422;5982.49148822355 08:55:05 INFO - PROCESS | 1662 | |1;ext.html;427.8704220856938;455.09663318313164;459.59096404200244;494.23887213690915;501.0630121672473;39626.80186599067;42635.573644263546;42773.144537109314;42787.57212427871;42818.357724634116;43714.56285437145;44389.7780511097;44399.33400998988;44430.11139777202;44599.77700111495;8393.790155246106;9308.488033158157;9529.618815247417;9552.996935321795;9558.091981261803;8353.415260931737;11178.608748693798;11455.198136130433;11476.540938362456;11588.59439919603;11420.885791142107;11446.484908179153;11517.769644607102;11545.307281563091;11547.191696581243;7151.32062454066;11500.482478288497;11531.019863311629;11565.479553420075;11595.826062609067;8382.203690649378;11073.557057717682;11349.716257093556;11357.318560886373;11554.53781848725;41640.79179604082;42067.78966105181;42076.3688544669;42130;42142.78928605368;3535.398982173037;3998.5001874765653;4022.416749571325;4047.3524236122375;4071.735337203102;29610.85194574035;29617.555736663966;29620;30490;30857.382852343053;3120.3135310231714;3124.671909449498;3276.1482014676117;3379.4086034943784;3380.4422270325367;487250;487479;490268.54865725443;491321;492628;54657.72671136698;66596.00105998413;66896;67388;67442.66278668576;67716.6614166926;67726;67826.66086669535;67861.32138678648;68150;16648.25082871274;16920.492385228215;16931.068791216603;16987.150642467826;16989.745153822703;11689.357085360387;11915;11941.582044628396;12873.613791586267;12981.350932453339;18472.03158386299;21772.782272177392;21814.89092554527;22407.55184896293;22440.10239590431;7720.266574675396;8683.435576687496;8738.126187381211;8856.424332418372;8870.294560159084;877.9604917778715;879.2526352600239;887.9689210877589;914.7118657622827;926.2266007883358;24908.879100440525;30674.051437487957;30888.0733577993;31043.534346984812;33030.50454243188;972.2402451562695;996.3125443444001;1034.5551412892528;1059.5391004912888;1065.6110519660267;14002.85997140036;14396;14487.565373038615;14686.779698304534;14697.92651036738;662150;666808;668167;668927;669486;53695;54206.45793542014;54206.45793542093;54235;54247.72876135673;1413.5194034028275;1416.9716605668036;1427.0724029380779;1428.728541577097;1436.6982933583856;26880.73119268782;27696.44607107887;28202.576961345185;28256.434871302048;28575.71409286629;47514;48165;48308.516914830405;48322.5167748318;48348.5165148344;577959;580989;581111;581706;581996;25932.481350373266;25978.87010565011;26365.604515931893;26432.471350572498;26459.60310595304;43643.345349819145;43860.561394386925;45000.77499612481;45022;45169.54830451653;29334.266643333234;34189.48715769216;35863.10342241465;36071.639283606826;37206.81396593;35748.4637730429;35880.4617930726;36590.63409365872;36834.447483288306;37032.814835925645;35066.29867402689;35240.295194096485;35862.28275434425;36056.63943360533;36251;27849.860750696116;28943.855280723463;32154.517682234316;32244;32477.675223247465;24021.148186941715;24090.51818963646;24100.276991690276;24122.638160427257;24267 08:55:05 INFO - PROCESS | 1662 | |2;jquery.html;371.75092687899104;393.616224181423;394.65270561905527;405.25837716977935;424.10302210824113;14542.781858272121;20914.6862797058;21253.93730313484;21634.134634614635;21885.343439696793;21019;21607.56784864302;22155.224567140154;22236.444088897784;22376.440588985282;5336.252924590551;5473.370562385317;5473.616846820724;5830.5044071254;5878.823635290927;5766.1639062335935;5790.218320526738;5837.211976383176;5858.824235272928;5862.179294898718;5796.217510636074;5798.681072541009;5810.360860305363;7334.339909408152;7793.103793063813;7523.849523009564;7756;7801.4929029612895;7826.256505631955;7828.9822323097915;7506;7534.982777325101;7542.69829206831;7562.395008399315;7632.580208088553;29927.700722992708;30257.69742302593;30364.54453183204;30392;30642.38715225683;2815.1233356030725;2837.702041285656;2842.7441530262167;2883.596296518489;2923.9122826315242;16237.431689890796;16422.260998255108;16866.578335541588;17067.57331066721;18030.36893708727;1925.2587753714781;1978.6405749929545;1988.463114958953;1991.800819918011;1999.0804230054193;139747;142066;163480;172798.1360093204;177074;21623.45941351479;22389.776102239095;23212;23831.92285967102;24321;40418;40818.122278383504;41496.58503414987;41797.58202417937;43118.353224701656;11064.170187235828;11323.263987840764;11537.769244615061;11758.823617645741;11799.823002654966;7660.578668173304;9048.276137908952;9108.726738197865;9151.17639412456;9360.694080722807;9199.77000574991;11144.888551114547;11222.551097956153;11267;11422.771544569063;3672.7979961102396;3958.9310886060603;4163.91804097951;4188.225178342016;4195.098053918422;848.898132224137;871.1897934920459;887.6804350433839;887.9189213429389;911.5032307392487;21257.04343304555;22107;22195.66706499404;22199.889000554893;22398.440038999157;885.3448448148324;911.4986757283467;915.1854849184232;919.1865199298669;929;10856.185786065918;11568.537258509734;11693.824592631117;11749.177557571058;11756.882431175749;745478;757994;758918;764716;772367;98065;101290;108437;155164.12089697848;155556;831.7380025292014;985.8521221816785;992.3153024413276;1004.5379125602159;1005.8088963096989;19897.602047959248;20632.17471301131;20829;20930.47673808167;20954.895225523775;56735.71632141813;58318.708406459395;59806.70096649663;60548;60624.6968765171;86126;86229;88249;88351;88625.68245905009;8312.168783121639;8412.242898139197;8421.19998600132;8602.4188999645;8744.256738177071;6666.500012499179;11629.53481860716;12741.617751467471;13678.179309241477;13708.588742337746;9478.431294122374;11239.04468120219;11339.489722962322;11609.767804644029;11611.535538578362;11197.496112674786;11344.716382090513;11404.258723182966;11455.140864435034;11687.298762074302;11566.30602163873;11613.6515904523;11705.88294117048;11719.88280117222;12025.579104731642;7108.431325494052;8529.786755330919;8591.012033615963;8733.257673097858;8880.687216167717;8180.263776260165;11203.943980280046;11311.208215424842;11722.413879306172;11830.82253766177 08:55:05 INFO - PROCESS | 1662 | |3;mootools.html;1235.2588446931838;1407.809945657336;1422.4736847366476;1424.5299051313064;1431.4131206205452;8188.5086894786355;8593.39846210764;8601.612927418266;8607.182317679826;8611.741647750561;7459.477836551444;7750.3799696024325;7761.45669803114;8107.797305067376;8351.415400921938;2289.6565515172692;2328.9184878529254;2333.439974406139;2334.8832558372096;2337.4623836517612;2317.2700599311247;2344.812415006804;2353.682252895863;2357.599208134621;2357.8821058946983;2045.8261047810954;2131.7228760261146;2232.1294695068937;2307.6500247355316;2321.7694621850446;1752.027624668315;2123.734533183352;2321.8374713770045;2322.7561106083954;2325.1396983116188;2269.7843704848015;2320.524292520029;2348.1429278313462;2356.399118224842;2357.7406485286606;7216.8917466238045;8468.237858592694;8564.528950907697;8570.700025499078;8584.442011269248;4524.389207456984;4975.577075948549;5013.89972200554;5140.33175687162;5146.356705411824;3355.728165039092;3514.841832117561;3546.2552863898613;3587.0852932502044;3596.3886139356373;1158.5344539157973;1202.3747651221404;1205.2105870654734;1246.4204145072586;1260.0171865944578;10841.620543281026;10916.563337466492;10938.12495000406;10997.450127493674;11004.449777511092;3832.48261484696;4187.330027195634;4406.9559304407185;4443.555644435531;4518.728876267434;8477;8486.0665326814;8575.271101956403;8600.311975041981;8625.266852317498;4935.7532123393685;4938.481459446706;4940.777665005012;4942.283368911488;4943.456219815817;3626.8730594429067;4266.829326826892;4425.380446737459;4620.306953956933;4766.785494652749;3813.932099012281;3851.6533511983494;3964.5440774311323;3969.0871099646665;3979.3235150024566;1281.557862537423;1301.6030110816102;1302.3683513495946;1312.8381382476578;1315.3620494060374;793.3890904003885;894.6645008121955;917.5045475443186;932.9253659707207;950.5484894674975;5472.5621950243885;5737.827865164052;5770.596058275964;5802;5933.436323549256;852.8209076093966;958.9280803939732;970.3498655900563;990.301837204769;1032.1020711980475;3637.909052273714;3675.4486826976167;3726.869559565402;3775.905602359963;3804.600516945736;9871.50642467888;9978.052085051908;10113.292069555207;10220.080192782685;10228.437435941094;10138.949305253427;10153.695389138338;10170.033846784543;10170.694879153638;10172.237082218715;7423.517471364344;7798.727044553413;7810.531368117818;7922.405819563441;7989.840203195903;5540.168974653834;5789.9710501447225;5860.150278209721;5871.442212989759;5914.674692891932;8943.284537236876;9081.45511269326;9099.090090990849;9299.581518831534;9420.670276540288;9182.357234993486;9413.529323533932;9474;9498.00270971538;9506.096920792514;6650.600963942179;6846.931530684629;7184.173820010766;7332.120145582564;7341.9632901837285;7494.925050749423;7922.445428819928;7983.560904150095;8064.951556297644;8065.87901181471;7055.894161587477;7119.501634885508;7139.714411423485;7182.928170718435;7277.59973201479;7039.436845052486;7042.964785176041;7049.541779784297;7068.611226382598;7115.395191408788;5077.8730531737;6365.61806291624;6493.155889734304;6495.837604059936;6496.0580715795;4249.87250382489;4904.983435187405;4962.652614316963;5020.774065167003;5145.871353216199;3824.808759561955;5021;5075.365579302587;5143.71709555978;5157.7679004445645 08:55:05 INFO - PROCESS | 1662 | |4;prototype.html;322.25880474907706;354.85805677728905;356.15235738941317;363.9836207370668;364.0225993208234;4849.321095046696;5220.608454365928;5262.447443018481;5302.814401495948;5330.413654498007;4506.8873278167985;4582.679212455129;4822.8425177957215;5145.768440420181;5225.216217567367;3590.1563132663805;3723.515942927416;3954.9802250988705;3997.8800635980965;4037.3540233562635;4062.2281766464425;4065.1869626074754;4083.3466645336753;4086.5504794472586;4099.3850922361735;3366.9158271043298;4063.9390409143884;4069.470968774055;4077;4083.203775263825;3777.0934975605933;3863.594322596115;3993.4409182714444;4050.4936882889638;4051.250518654044;3214.5352900069975;3297.7526685498683;3514.279572687593;3520.9471857922154;3532.91167720809;4461.486929003141;5050.772715227787;5066.265391518246;5068.670536415121;5111.1566591512355;4218.915621687549;4505.932411013838;4609.510864133364;4622.537746225385;4670.509596492388;4967.839878550607;5146.092457761353;5549.278593782782;5572.241740338518;5601.495865372095;3243.8702451901895;3305.983470082634;3802.7338086333966;3820.178661587744;3842.654161125512;5551.168114522238;5702.54379649627;5775.422457754233;5831.3877042910735;5890.614301208017;3012.9246768830953;3290;3799.1831756172555;3817.7136714746507;3824.1395685970433;3343.7659363844296;3868.6131386861653;3870.3807390817897;3894.9221015580097;3901.356276214393;4509.887252818706;4514.480834704051;4551.362809206714;4566.607184808665;4569.54304569547;5174.534291913746;5315.309009828775;5501.184609078994;5548.861278468071;5658.207850900877;1126.4705588373452;1240.1009268280604;1240.5161986825146;1243.7574672938872;1245.4768997021272;785.9586048485666;797.8484088023257;831.2975535672347;844.0462277626366;846.6909578004107;4500.5823165702695;4541.613962813198;4698.95301046992;4915.852524424273;5090.516400941905;5616.887662246814;5658.660480371191;5670.376258611549;5678.858028549319;5702.144678298206;4926.679765815211;5075.746212689351;5093.8726531837;5119.232115182678;5134.2812006319145;2613.8368426050224;2625.9889942372324;2836.957445638317;2856.2859285178706;2870.7846911481724;5640.71796410186;5664.745086471119;5668.291463567054;5680.829575112753;5685.60200785941;5070.776471996086;5124.846254612293;5493.901219756065;5604.775808967677;5626.831195064155;4833.148442418989;5151.4590967949325;5566.832995010156;5605.691686957175;5679.166562570331;4967.776450059684;5319.601029922848;5435.83692489226;5439.864003399946;5471.8084867029465;4786.0667169901535;4803.55018940336;4857.878553036202;4922.1632322505975;5205.8177963772605;5244.977229440223;5326.215717734447;5628.960361404959;5648.661080335193;5669.688167150682;3171.936561268808;3234.336960922958;3577.6422357765055;3612.898066089868;3675.6875665568728;4475.641948644035;4751.881202969954;5677.886442271214;5706.629069110661;5765.423457654201;4696.835610753607;5057.165567681292;5485.259489968803;5525.950069486785;5532.280803495681;5207.609429292894;5243.921341179809;5569;5576.442355764391;5631.971840140773;4736.8578942631775;4989.850304490871;5173.8876141628225;5343.984642917833;5366.7048312343195;5231.3199284092825;5268.525832675077;5357.464073711331;5405.567524605904;5507.7246137692155;5395.946040539544;5404.756785944721;5425.83722488326;5426;5464.972675136599 08:55:05 INFO - PROCESS | 1662 | |5;yui.html;699.9440044796416;724.7101159536188;765.0245936431053;822.9423940324178;836.0677844203711;14798.186099764509;15596.688066238668;15621.140837253946;15630.843691563081;15656.13891235983;13356.53252136173;13969.206178497612;14246.287685615729;14385.64035899103;14429.350679219435;865.0527672198932;868.4875923205308;884.0893879304294;884.747846863644;885.3183049052226;879.5821984557316;882.2104216726026;882.8940527136753;883.6023789294811;884.1379654836547;932.6362718539741;933.0809152984305;933.8225737109962;935.4247138010109;935.4854829843558;921.8525035994209;923.6951805904035;924.1220840201768;924.5146298193436;928.5682157796623;688.8209065642969;690.837653151509;693.8126705789459;694.0907411291224;694.8957656351537;13413.597592072254;13589.252591107484;14630.853691463162;15019.474318398912;15209.467668631545;12477.625671229787;13185;13779.724405511834;13782.586522404345;13826.516071937434;11600.593979210771;11691.298522088617;11775.352355620438;11875.703107422298;11913.166078374517;3572.9285414291567;3632.5096112025067;3665.8350374233223;3736.7757934524016;3830.559485659129;47488.762556187;88446;104405.47797260965;105510.94489055088;105788;10443.477826108665;10561.735956600993;10578.52396642153;10719.678409647722;10909.236353455182;22009.11963521473;22235.332940011504;22283.777162228493;22329.665055024187;22376.55246895053;7646.120696120018;7753.689852405953;7757.7672669819995;7772.961135194288;7845.960770196227;4178.498580170399;4270.188664153801;4270.466191726035;4280.165367753259;4350.912981740347;3550.431930891045;3628.310620982005;3631.2011357501306;3655.7753152694145;3672.2839046386234;631.908373285871;632.8860805055134;637.4581605635173;650.9909640057891;652.7062821730241;667.4393509452084;675.6216518749516;684.8323608247925;692.2350802363417;731.9341259286583;9353.158215760614;9784.266180036526;9856.606841038305;10298.021687939634;10535.63125290611;686.1457485430572;695.8434352270699;702.6486756621689;703.7325816189917;706.9964650176717;4458.687891847604;4880.31675565414;4892.363992681;4900.191468407673;4902.828401005948;80788.59605702052;94710;95687.52156239175;96000;97488.05023899623;55892;57339.42660573425;64918;75404.62297688586;92033;77507;77965.61017194878;78185.60907195427;78733;79260.6036969823;10516.211284153565;10755.354678719303;10834.241603087708;11030.44847757625;11030.944845276043;44642.55357446384;45616.859578510805;50021;50676.239856401444;51884.70288242824;50011.49988500068;65509;67219.66390168018;67359.65280694456;67791.32208678048;12725.996924500654;12847.421866016239;12952.158109722837;12961.740765184832;13211.813337317442;13879;14162.858371416154;14243.715125697221;14383.640408989859;14690.706185876435;13154.294299971703;13451.125676830974;13507.986900982662;13616.774779903231;13843.377048032662;12154.209976351509;12942.547010854574;13078.411471483996;13586.388612512263;14008.369623367176;12346.81479777786;13175.070035004972;13359.666008349868;13387.343183163994;13650.112742671694;10615.595075239398;11125.777484450104;11291.491882865126;11315.773684526428;11456.656300311004;9393.483358415353;10244.743881402726;10506.326603466716;10843.024127828534;10938.726531836768 08:55:05 INFO - PROCESS | 1662 | __end_tp_report 08:55:05 INFO - PROCESS | 1662 | __start_cc_report 08:55:05 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2052 08:55:05 INFO - PROCESS | 1662 | __end_cc_report 08:55:05 INFO - PROCESS | 1662 | __startTimestamp1488128105531__endTimestamp 08:55:05 INFO - PROCESS | 1662 | 08:55:05 INFO - PROCESS | 1662 | ------- Summary: start ------- 08:55:05 INFO - PROCESS | 1662 | Number of tests: 6 08:55:05 INFO - PROCESS | 1662 | 08:55:05 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5788.11 Median:5982.49 stddev:641.68 (10.7%) stddev-sans-first:609.73 08:55:05 INFO - PROCESS | 1662 | Values: 3163.5 3354.4 3367.3 3406.4 3418.2 5654.9 5683.9 5714.6 5731.0 5756.8 5721.2 5734.6 5810.5 5815.4 5819.1 5226.8 5236.7 5256.9 5312.2 5324.7 5137.6 5143.4 5160.7 5330.8 5333.8 5216.7 5224.4 5228.3 5288.8 5339.4 5313.8 5314.9 5317.6 5322.4 5329.2 5117.4 5166.1 5238.9 5260.4 5302.2 5594.5 5608.7 5653.3 5653.9 5654.7 6274.7 6278.1 6330.4 6335.3 6351.2 6248.8 6314.1 6318.8 6329.2 6330.3 5689.6 5749.0 5825.3 5890.2 5902.2 6246.2 6277.9 6287.1 6287.1 6324.1 6199.3 6199.6 6199.7 6216.3 6223.2 6238.7 6280.4 6288.2 6303.7 6311.0 6109.8 6175.3 6187.8 6241.7 6247.6 6316.9 6332.0 6346.6 6348.4 6350.6 5036.4 5037.5 5053.1 5055.9 5062.2 4386.6 4446.6 4447.8 4477.8 4491.9 5723.9 5757.6 5770.5 5781.5 5784.6 6259.2 6297.2 6300.5 6315.7 6316.6 5880.5 5923.2 5926.7 5932.8 5939.6 5489.5 5489.8 5497.0 5500.1 5513.6 6215.6 6221.1 6255.0 6281.6 6358.8 6248.3 6295.7 6318.2 6334.7 6342.0 6304.0 6305.5 6312.7 6322.9 6344.0 6132.8 6133.3 6210.0 6211.4 6227.3 6212.4 6216.2 6221.7 6250.3 6255.4 6134.4 6156.6 6159.6 6170.1 6171.5 5305.4 6026.8 6091.1 6150.8 6189.1 5867.4 5964.5 6001.1 6038.0 6118.8 6153.1 6205.9 6213.1 6219.8 6221.3 5850.4 5890.5 5896.4 5965.5 5982.5 08:55:05 INFO - PROCESS | 1662 | 08:55:05 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:71075.54 Median:36161.32 stddev:156094.27 (431.7%) stddev-sans-first:156442.03 08:55:05 INFO - PROCESS | 1662 | Values: 427.9 455.1 459.6 494.2 501.1 39626.8 42635.6 42773.1 42787.6 42818.4 43714.6 44389.8 44399.3 44430.1 44599.8 8393.8 9308.5 9529.6 9553.0 9558.1 8353.4 11178.6 11455.2 11476.5 11588.6 11420.9 11446.5 11517.8 11545.3 11547.2 7151.3 11500.5 11531.0 11565.5 11595.8 8382.2 11073.6 11349.7 11357.3 11554.5 41640.8 42067.8 42076.4 42130.0 42142.8 3535.4 3998.5 4022.4 4047.4 4071.7 29610.9 29617.6 29620.0 30490.0 30857.4 3120.3 3124.7 3276.1 3379.4 3380.4 487250.0 487479.0 490268.5 491321.0 492628.0 54657.7 66596.0 66896.0 67388.0 67442.7 67716.7 67726.0 67826.7 67861.3 68150.0 16648.3 16920.5 16931.1 16987.2 16989.7 11689.4 11915.0 11941.6 12873.6 12981.4 18472.0 21772.8 21814.9 22407.6 22440.1 7720.3 8683.4 8738.1 8856.4 8870.3 878.0 879.3 888.0 914.7 926.2 24908.9 30674.1 30888.1 31043.5 33030.5 972.2 996.3 1034.6 1059.5 1065.6 14002.9 14396.0 14487.6 14686.8 14697.9 662150.0 666808.0 668167.0 668927.0 669486.0 53695.0 54206.5 54206.5 54235.0 54247.7 1413.5 1417.0 1427.1 1428.7 1436.7 26880.7 27696.4 28202.6 28256.4 28575.7 47514.0 48165.0 48308.5 48322.5 48348.5 577959.0 580989.0 581111.0 581706.0 581996.0 25932.5 25978.9 26365.6 26432.5 26459.6 43643.3 43860.6 45000.8 45022.0 45169.5 29334.3 34189.5 35863.1 36071.6 37206.8 35748.5 35880.5 36590.6 36834.4 37032.8 35066.3 35240.3 35862.3 36056.6 36251.0 27849.9 28943.9 32154.5 32244.0 32477.7 24021.1 24090.5 24100.3 24122.6 24267.0 08:55:05 INFO - PROCESS | 1662 | 08:55:05 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:42983.48 Median:30517.19 stddev:126233.19 (413.6%) stddev-sans-first:126546.76 08:55:05 INFO - PROCESS | 1662 | Values: 371.8 393.6 394.7 405.3 424.1 14542.8 20914.7 21253.9 21634.1 21885.3 21019.0 21607.6 22155.2 22236.4 22376.4 5336.3 5473.4 5473.6 5830.5 5878.8 5766.2 5790.2 5837.2 5858.8 5862.2 5796.2 5798.7 5810.4 7334.3 7793.1 7523.8 7756.0 7801.5 7826.3 7829.0 7506.0 7535.0 7542.7 7562.4 7632.6 29927.7 30257.7 30364.5 30392.0 30642.4 2815.1 2837.7 2842.7 2883.6 2923.9 16237.4 16422.3 16866.6 17067.6 18030.4 1925.3 1978.6 1988.5 1991.8 1999.1 139747.0 142066.0 163480.0 172798.1 177074.0 21623.5 22389.8 23212.0 23831.9 24321.0 40418.0 40818.1 41496.6 41797.6 43118.4 11064.2 11323.3 11537.8 11758.8 11799.8 7660.6 9048.3 9108.7 9151.2 9360.7 9199.8 11144.9 11222.6 11267.0 11422.8 3672.8 3958.9 4163.9 4188.2 4195.1 848.9 871.2 887.7 887.9 911.5 21257.0 22107.0 22195.7 22199.9 22398.4 885.3 911.5 915.2 919.2 929.0 10856.2 11568.5 11693.8 11749.2 11756.9 745478.0 757994.0 758918.0 764716.0 772367.0 98065.0 101290.0 108437.0 155164.1 155556.0 831.7 985.9 992.3 1004.5 1005.8 19897.6 20632.2 20829.0 20930.5 20954.9 56735.7 58318.7 59806.7 60548.0 60624.7 86126.0 86229.0 88249.0 88351.0 88625.7 8312.2 8412.2 8421.2 8602.4 8744.3 6666.5 11629.5 12741.6 13678.2 13708.6 9478.4 11239.0 11339.5 11609.8 11611.5 11197.5 11344.7 11404.3 11455.1 11687.3 11566.3 11613.7 11705.9 11719.9 12025.6 7108.4 8529.8 8591.0 8733.3 8880.7 8180.3 11203.9 11311.2 11722.4 11830.8 08:55:05 INFO - PROCESS | 1662 | 08:55:05 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5395.43 Median:5017.34 stddev:2962.39 (59.0%) stddev-sans-first:2954.19 08:55:05 INFO - PROCESS | 1662 | Values: 1235.3 1407.8 1422.5 1424.5 1431.4 8188.5 8593.4 8601.6 8607.2 8611.7 7459.5 7750.4 7761.5 8107.8 8351.4 2289.7 2328.9 2333.4 2334.9 2337.5 2317.3 2344.8 2353.7 2357.6 2357.9 2045.8 2131.7 2232.1 2307.7 2321.8 1752.0 2123.7 2321.8 2322.8 2325.1 2269.8 2320.5 2348.1 2356.4 2357.7 7216.9 8468.2 8564.5 8570.7 8584.4 4524.4 4975.6 5013.9 5140.3 5146.4 3355.7 3514.8 3546.3 3587.1 3596.4 1158.5 1202.4 1205.2 1246.4 1260.0 10841.6 10916.6 10938.1 10997.5 11004.4 3832.5 4187.3 4407.0 4443.6 4518.7 8477.0 8486.1 8575.3 8600.3 8625.3 4935.8 4938.5 4940.8 4942.3 4943.5 3626.9 4266.8 4425.4 4620.3 4766.8 3813.9 3851.7 3964.5 3969.1 3979.3 1281.6 1301.6 1302.4 1312.8 1315.4 793.4 894.7 917.5 932.9 950.5 5472.6 5737.8 5770.6 5802.0 5933.4 852.8 958.9 970.3 990.3 1032.1 3637.9 3675.4 3726.9 3775.9 3804.6 9871.5 9978.1 10113.3 10220.1 10228.4 10138.9 10153.7 10170.0 10170.7 10172.2 7423.5 7798.7 7810.5 7922.4 7989.8 5540.2 5790.0 5860.2 5871.4 5914.7 8943.3 9081.5 9099.1 9299.6 9420.7 9182.4 9413.5 9474.0 9498.0 9506.1 6650.6 6846.9 7184.2 7332.1 7342.0 7494.9 7922.4 7983.6 8065.0 8065.9 7055.9 7119.5 7139.7 7182.9 7277.6 7039.4 7043.0 7049.5 7068.6 7115.4 5077.9 6365.6 6493.2 6495.8 6496.1 4249.9 4905.0 4962.7 5020.8 5145.9 3824.8 5021.0 5075.4 5143.7 5157.8 08:55:05 INFO - PROCESS | 1662 | 08:55:05 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4414.68 Median:4978.85 stddev:1358.87 (27.3%) stddev-sans-first:1327.51 08:55:05 INFO - PROCESS | 1662 | Values: 322.3 354.9 356.2 364.0 364.0 4849.3 5220.6 5262.4 5302.8 5330.4 4506.9 4582.7 4822.8 5145.8 5225.2 3590.2 3723.5 3955.0 3997.9 4037.4 4062.2 4065.2 4083.3 4086.6 4099.4 3366.9 4063.9 4069.5 4077.0 4083.2 3777.1 3863.6 3993.4 4050.5 4051.3 3214.5 3297.8 3514.3 3520.9 3532.9 4461.5 5050.8 5066.3 5068.7 5111.2 4218.9 4505.9 4609.5 4622.5 4670.5 4967.8 5146.1 5549.3 5572.2 5601.5 3243.9 3306.0 3802.7 3820.2 3842.7 5551.2 5702.5 5775.4 5831.4 5890.6 3012.9 3290.0 3799.2 3817.7 3824.1 3343.8 3868.6 3870.4 3894.9 3901.4 4509.9 4514.5 4551.4 4566.6 4569.5 5174.5 5315.3 5501.2 5548.9 5658.2 1126.5 1240.1 1240.5 1243.8 1245.5 786.0 797.8 831.3 844.0 846.7 4500.6 4541.6 4699.0 4915.9 5090.5 5616.9 5658.7 5670.4 5678.9 5702.1 4926.7 5075.7 5093.9 5119.2 5134.3 2613.8 2626.0 2837.0 2856.3 2870.8 5640.7 5664.7 5668.3 5680.8 5685.6 5070.8 5124.8 5493.9 5604.8 5626.8 4833.1 5151.5 5566.8 5605.7 5679.2 4967.8 5319.6 5435.8 5439.9 5471.8 4786.1 4803.6 4857.9 4922.2 5205.8 5245.0 5326.2 5629.0 5648.7 5669.7 3171.9 3234.3 3577.6 3612.9 3675.7 4475.6 4751.9 5677.9 5706.6 5765.4 4696.8 5057.2 5485.3 5526.0 5532.3 5207.6 5243.9 5569.0 5576.4 5632.0 4736.9 4989.9 5173.9 5344.0 5366.7 5231.3 5268.5 5357.5 5405.6 5507.7 5395.9 5404.8 5425.8 5426.0 5465.0 08:55:05 INFO - PROCESS | 1662 | 08:55:05 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:19041.86 Median:4270.33 stddev:26365.84 (617.4%) stddev-sans-first:26403.83 08:55:05 INFO - PROCESS | 1662 | Values: 699.9 724.7 765.0 822.9 836.1 14798.2 15596.7 15621.1 15630.8 15656.1 13356.5 13969.2 14246.3 14385.6 14429.4 865.1 868.5 884.1 884.7 885.3 879.6 882.2 882.9 883.6 884.1 932.6 933.1 933.8 935.4 935.5 921.9 923.7 924.1 924.5 928.6 688.8 690.8 693.8 694.1 694.9 13413.6 13589.3 14630.9 15019.5 15209.5 12477.6 13185.0 13779.7 13782.6 13826.5 11600.6 11691.3 11775.4 11875.7 11913.2 3572.9 3632.5 3665.8 3736.8 3830.6 47488.8 88446.0 104405.5 105510.9 105788.0 10443.5 10561.7 10578.5 10719.7 10909.2 22009.1 22235.3 22283.8 22329.7 22376.6 7646.1 7753.7 7757.8 7773.0 7846.0 4178.5 4270.2 4270.5 4280.2 4350.9 3550.4 3628.3 3631.2 3655.8 3672.3 631.9 632.9 637.5 651.0 652.7 667.4 675.6 684.8 692.2 731.9 9353.2 9784.3 9856.6 10298.0 10535.6 686.1 695.8 702.6 703.7 707.0 4458.7 4880.3 4892.4 4900.2 4902.8 80788.6 94710.0 95687.5 96000.0 97488.1 55892.0 57339.4 64918.0 75404.6 92033.0 77507.0 77965.6 78185.6 78733.0 79260.6 10516.2 10755.4 10834.2 11030.4 11030.9 44642.6 45616.9 50021.0 50676.2 51884.7 50011.5 65509.0 67219.7 67359.7 67791.3 12726.0 12847.4 12952.2 12961.7 13211.8 13879.0 14162.9 14243.7 14383.6 14690.7 13154.3 13451.1 13508.0 13616.8 13843.4 12154.2 12942.5 13078.4 13586.4 14008.4 12346.8 13175.1 13359.7 13387.3 13650.1 10615.6 11125.8 11291.5 11315.8 11456.7 9393.5 10244.7 10506.3 10843.0 10938.7 08:55:05 INFO - PROCESS | 1662 | -------- Summary: end -------- 08:55:05 INFO - PROCESS | 1662 | 08:55:05 INFO - PROCESS | 1662 | 1488128105553 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 08:55:06 INFO - TEST-INFO | 1662: exit 0 08:55:06 INFO - TEST-OK | dromaeo_css | took 1118373ms 08:55:06 INFO - TEST-START | kraken 08:55:06 INFO - operating with platform_type : mac_ 08:55:06 INFO - Initialising browser for kraken test... 08:55:06 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpJjWX1S/profile http://localhost:49244/getInfo.html) 08:55:06 INFO - PROCESS | 1668 | 1488128106713 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 08:55:06 INFO - PROCESS | 1668 | 1488128106713 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 08:55:06 INFO - PROCESS | 1668 | 1488128106761 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 08:55:08 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 08:55:08 INFO - PROCESS | 1668 | colorDepth:24 08:55:08 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 08:55:08 INFO - PROCESS | 1668 | __metrics 08:55:08 INFO - PROCESS | 1668 | 1488128108781 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 08:55:08 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:55:08 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:09 INFO - TEST-INFO | 1668: exit 0 08:55:09 INFO - Browser initialized. 08:55:09 INFO - Running cycle 1/1 for kraken test... 08:55:09 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpJjWX1S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:09 INFO - PROCESS | 1669 | 1488128109881 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 08:55:09 INFO - PROCESS | 1669 | 1488128109882 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 08:55:21 INFO - PROCESS | 1669 | RSS: Main: 213434368 08:55:21 INFO - PROCESS | 1669 | 08:55:24 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 08:55:25 INFO - PROCESS | 1669 | RSS: Main: 267063296 08:55:25 INFO - PROCESS | 1669 | 08:55:27 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 08:55:28 INFO - PROCESS | 1669 | RSS: Main: 277200896 08:55:28 INFO - PROCESS | 1669 | 08:55:31 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 08:55:32 INFO - PROCESS | 1669 | RSS: Main: 372596736 08:55:32 INFO - PROCESS | 1669 | 08:55:34 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 08:55:34 INFO - PROCESS | 1669 | RSS: Main: 275783680 08:55:34 INFO - PROCESS | 1669 | 08:55:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:55:37 INFO - PROCESS | 1669 | RSS: Main: 277127168 08:55:37 INFO - PROCESS | 1669 | 08:55:40 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 08:55:40 INFO - PROCESS | 1669 | RSS: Main: 316981248 08:55:40 INFO - PROCESS | 1669 | 08:55:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 08:55:44 INFO - PROCESS | 1669 | RSS: Main: 318226432 08:55:44 INFO - PROCESS | 1669 | 08:55:47 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 08:55:47 INFO - PROCESS | 1669 | RSS: Main: 315867136 08:55:47 INFO - PROCESS | 1669 | 08:55:49 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:55:50 INFO - PROCESS | 1669 | RSS: Main: 294719488 08:55:50 INFO - PROCESS | 1669 | 08:55:52 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:55:52 INFO - PROCESS | 1669 | RSS: Main: 295129088 08:55:52 INFO - PROCESS | 1669 | 08:55:54 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:55:55 INFO - PROCESS | 1669 | RSS: Main: 298160128 08:55:55 INFO - PROCESS | 1669 | 08:55:58 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:55:59 INFO - PROCESS | 1669 | RSS: Main: 317911040 08:55:59 INFO - PROCESS | 1669 | 08:56:02 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:56:02 INFO - PROCESS | 1669 | RSS: Main: 311455744 08:56:02 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 08:56:04 INFO - PROCESS | 1669 | RSS: Main: 356171776 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | __start_tp_report 08:56:04 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 08:56:04 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 08:56:04 INFO - PROCESS | 1669 | |i|pagename|runs| 08:56:04 INFO - PROCESS | 1669 | |0;ai-astar;113;123;169;146;113;113;113;112;116;113 08:56:04 INFO - PROCESS | 1669 | |1;audio-beat-detection;141;107;112;143;109;109;109;107;127;108 08:56:04 INFO - PROCESS | 1669 | |2;audio-dft;185;183;181;185;184;184;183;186;237;183 08:56:04 INFO - PROCESS | 1669 | |3;audio-fft;81;58;58;89;61;60;59;58;75;59 08:56:04 INFO - PROCESS | 1669 | |4;audio-oscillator;85;69;85;70;68;69;82;68;90;114 08:56:04 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;88;83;128;84;88;84;88;85;87;85 08:56:04 INFO - PROCESS | 1669 | |6;imaging-darkroom;93;94;94;94;93;94;94;94;94;94 08:56:04 INFO - PROCESS | 1669 | |7;imaging-desaturate;87;84;89;85;87;86;87;87;87;87 08:56:04 INFO - PROCESS | 1669 | |8;json-parse-financial;53;51;74;89;90;89;56;56;54;58 08:56:04 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;66;76;67;75;76;68;68;69;70;71 08:56:04 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;82;83;83;87;84;84;83;82;83;87 08:56:04 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;140;165;145;151;137;140;145;133;195;169 08:56:04 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;209;228;156;216;226;183;166;168;169;168 08:56:04 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;67;66;66;66;65;66;65;66;64;65 08:56:04 INFO - PROCESS | 1669 | __end_tp_report 08:56:04 INFO - PROCESS | 1669 | __start_cc_report 08:56:04 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,2034 08:56:04 INFO - PROCESS | 1669 | __end_cc_report 08:56:04 INFO - PROCESS | 1669 | __startTimestamp1488128164945__endTimestamp 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | ------- Summary: start ------- 08:56:04 INFO - PROCESS | 1669 | Number of tests: 14 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:123.10 Median:114.50 stddev:19.19 (16.8%) stddev-sans-first:20.00 08:56:04 INFO - PROCESS | 1669 | Values: 113.0 123.0 169.0 146.0 113.0 113.0 113.0 112.0 116.0 113.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:110.50 stddev:14.34 (13.0%) stddev-sans-first:12.35 08:56:04 INFO - PROCESS | 1669 | Values: 141.0 107.0 112.0 143.0 109.0 109.0 109.0 107.0 127.0 108.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:189.10 Median:184.50 stddev:16.89 (9.2%) stddev-sans-first:17.85 08:56:04 INFO - PROCESS | 1669 | Values: 185.0 183.0 181.0 185.0 184.0 184.0 183.0 186.0 237.0 183.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.50 stddev:11.48 (19.0%) stddev-sans-first:10.78 08:56:04 INFO - PROCESS | 1669 | Values: 81.0 58.0 58.0 89.0 61.0 60.0 59.0 58.0 75.0 59.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:76.00 stddev:14.68 (19.3%) stddev-sans-first:15.46 08:56:04 INFO - PROCESS | 1669 | Values: 85.0 69.0 85.0 70.0 68.0 69.0 82.0 68.0 90.0 114.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:86.00 stddev:13.48 (15.7%) stddev-sans-first:14.28 08:56:04 INFO - PROCESS | 1669 | Values: 88.0 83.0 128.0 84.0 88.0 84.0 88.0 85.0 87.0 85.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:56:04 INFO - PROCESS | 1669 | Values: 93.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.00 stddev:1.35 (1.6%) stddev-sans-first:1.42 08:56:04 INFO - PROCESS | 1669 | Values: 87.0 84.0 89.0 85.0 87.0 86.0 87.0 87.0 87.0 87.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:66.00 stddev:16.63 (25.2%) stddev-sans-first:16.85 08:56:04 INFO - PROCESS | 1669 | Values: 53.0 51.0 74.0 89.0 90.0 89.0 56.0 56.0 54.0 58.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:70.50 stddev:3.78 (5.4%) stddev-sans-first:3.62 08:56:04 INFO - PROCESS | 1669 | Values: 66.0 76.0 67.0 75.0 76.0 68.0 68.0 69.0 70.0 71.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:1.81 (2.2%) stddev-sans-first:1.80 08:56:04 INFO - PROCESS | 1669 | Values: 82.0 83.0 83.0 87.0 84.0 84.0 83.0 82.0 83.0 87.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:148.00 stddev:19.09 (12.9%) stddev-sans-first:19.75 08:56:04 INFO - PROCESS | 1669 | Values: 140.0 165.0 145.0 151.0 137.0 140.0 145.0 133.0 195.0 169.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.90 Median:196.00 stddev:27.80 (14.2%) stddev-sans-first:28.52 08:56:04 INFO - PROCESS | 1669 | Values: 209.0 228.0 156.0 216.0 226.0 183.0 166.0 168.0 169.0 168.0 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.73 08:56:04 INFO - PROCESS | 1669 | Values: 67.0 66.0 66.0 66.0 65.0 66.0 65.0 66.0 64.0 65.0 08:56:04 INFO - PROCESS | 1669 | -------- Summary: end -------- 08:56:04 INFO - PROCESS | 1669 | 08:56:04 INFO - PROCESS | 1669 | 1488128164965 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 08:56:05 INFO - TEST-INFO | 1669: exit 0 08:56:05 INFO - TEST-OK | kraken | took 59788ms 08:56:05 INFO - SUITE-END | took 1178s 08:56:06 INFO - Completed test suite (00:19:38) 08:56:06 INFO - javascript benchmark 08:56:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3163.525471179323, 3354.4297469430185, 3367.3433680432327, 3406.386850366936, 3418.1796368871464, 5654.9151762723595, 5683.886322273557, 5714.599978001536, 5730.997075511789, 5756.769729210827, 5721.227634269372, 5734.569907256951, 5810.535157187425, 5815.447532484418, 5819.127130930363, 5226.817061402861, 5236.727766800867, 5256.947430525704, 5312.17661262503, 5324.65389749667, 5137.614678899079, 5143.3570803649545, 5160.6903585784785, 5330.786768529254, 5333.839984800462, 5216.66091704038, 5224.39919409269, 5228.294180285651, 5288.762005709752, 5339.385970613371, 5313.814016509442, 5314.92027619586, 5317.574594032468, 5322.361316641989, 5329.227262046981, 5117.385913690381, 5166.07010738067, 5238.8690282742855, 5260.447652996419, 5302.2046692996355, 5594.496495315441, 5608.747606357723, 5653.265075540195, 5653.9151912721345, 5654.74553645087, 6274.686265686697, 6278.058291256302, 6330.366963303679, 6335.334789847046, 6351.174347334863, 6248.812535623939, 6314.052892066181, 6318.842028949267, 6329.240491141092, 6330.27201871786, 5689.630174038674, 5749.022666146765, 5825.271841019872, 5890.175375447441, 5902.173695682608, 6246.15676883624, 6277.905831412532, 6287.088372186007, 6287.1198032275515, 6324.146240257598, 6199.256089269226, 6199.5970261933735, 6199.721012554446, 6216.347283535254, 6223.190985171898, 6238.656873871981, 6280.371962803683, 6288.151099601587, 6303.716332765037, 6310.968445157745, 6109.799438327889, 6175.320714721377, 6187.783427580013, 6241.687915604201, 6247.562670613013, 6316.9368306317265, 6331.968340158362, 6346.555741098079, 6348.365163483707, 6350.555461117678, 5036.370453693288, 5037.546620804145, 5053.1157047516535, 5055.8988820223385, 5062.240663900371, 4386.605205531518, 4446.599806017474, 4447.844325448594, 4477.753723545236, 4491.887702807456, 5723.914141287884, 5757.625754325955, 5770.538356931435, 5781.4507621775865, 5784.623999440023, 6259.2488901332135, 6297.2128483939505, 6300.464460520907, 6315.684215789284, 6316.589421687576, 5880.529557635379, 5923.17075609415, 5926.703664816742, 5932.822015339547, 5939.643621382731, 5489.533389661844, 5489.752961116759, 5497.038018346773, 5500.064988951808, 5513.558915286768, 6215.564910456315, 6221.097940798469, 6254.9687251563455, 6281.623102613858, 6358.841028974312, 6248.250209974651, 6295.653739044396, 6318.178636777189, 6334.746610135728, 6342.0, 6303.9684801575695, 6305.464035557029, 6312.747490100344, 6322.8735425290315, 6344.0, 6132.846678832886, 6133.334663918993, 6209.975354066529, 6211.409916057967, 6227.252729672287, 6212.378762123752, 6216.160818289473, 6221.720022599085, 6250.312465628686, 6255.374462553708, 6134.35589263121, 6156.569040167145, 6159.5688301818445, 6170.10533472653, 6171.537134714825, 5305.363356397257, 6026.789062382795, 6091.116788065794, 6150.846228844314, 6189.1025801257665, 5867.354590995073, 5964.493018093511, 6001.099835024606, 6038.033914573647, 6118.785842495491, 6153.094738520792, 6205.906911396423, 6213.099100630474, 6219.813405597839, 6221.253449585897, 5850.356460789395, 5890.4698577128265, 5896.351401345934, 5965.522758179422, 5982.49148822355], "value": 5746.012934527661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.8704220856938, 455.09663318313164, 459.59096404200244, 494.23887213690915, 501.0630121672473, 39626.80186599067, 42635.573644263546, 42773.144537109314, 42787.57212427871, 42818.357724634116, 43714.56285437145, 44389.7780511097, 44399.33400998988, 44430.11139777202, 44599.77700111495, 8393.790155246106, 9308.488033158157, 9529.618815247417, 9552.996935321795, 9558.091981261803, 8353.415260931737, 11178.608748693798, 11455.198136130433, 11476.540938362456, 11588.59439919603, 11420.885791142107, 11446.484908179153, 11517.769644607102, 11545.307281563091, 11547.191696581243, 7151.32062454066, 11500.482478288497, 11531.019863311629, 11565.479553420075, 11595.826062609067, 8382.203690649378, 11073.557057717682, 11349.716257093556, 11357.318560886373, 11554.53781848725, 41640.79179604082, 42067.78966105181, 42076.3688544669, 42130.0, 42142.78928605368, 3535.398982173037, 3998.5001874765653, 4022.416749571325, 4047.3524236122375, 4071.735337203102, 29610.85194574035, 29617.555736663966, 29620.0, 30490.0, 30857.382852343053, 3120.3135310231714, 3124.671909449498, 3276.1482014676117, 3379.4086034943784, 3380.4422270325367, 487250.0, 487479.0, 490268.54865725443, 491321.0, 492628.0, 54657.72671136698, 66596.00105998413, 66896.0, 67388.0, 67442.66278668576, 67716.6614166926, 67726.0, 67826.66086669535, 67861.32138678648, 68150.0, 16648.25082871274, 16920.492385228215, 16931.068791216603, 16987.150642467826, 16989.745153822703, 11689.357085360387, 11915.0, 11941.582044628396, 12873.613791586267, 12981.350932453339, 18472.03158386299, 21772.782272177392, 21814.89092554527, 22407.55184896293, 22440.10239590431, 7720.266574675396, 8683.435576687496, 8738.126187381211, 8856.424332418372, 8870.294560159084, 877.9604917778715, 879.2526352600239, 887.9689210877589, 914.7118657622827, 926.2266007883358, 24908.879100440525, 30674.051437487957, 30888.0733577993, 31043.534346984812, 33030.50454243188, 972.2402451562695, 996.3125443444001, 1034.5551412892528, 1059.5391004912888, 1065.6110519660267, 14002.85997140036, 14396.0, 14487.565373038615, 14686.779698304534, 14697.92651036738, 662150.0, 666808.0, 668167.0, 668927.0, 669486.0, 53695.0, 54206.45793542014, 54206.45793542093, 54235.0, 54247.72876135673, 1413.5194034028275, 1416.9716605668036, 1427.0724029380779, 1428.728541577097, 1436.6982933583856, 26880.73119268782, 27696.44607107887, 28202.576961345185, 28256.434871302048, 28575.71409286629, 47514.0, 48165.0, 48308.516914830405, 48322.5167748318, 48348.5165148344, 577959.0, 580989.0, 581111.0, 581706.0, 581996.0, 25932.481350373266, 25978.87010565011, 26365.604515931893, 26432.471350572498, 26459.60310595304, 43643.345349819145, 43860.561394386925, 45000.77499612481, 45022.0, 45169.54830451653, 29334.266643333234, 34189.48715769216, 35863.10342241465, 36071.639283606826, 37206.81396593, 35748.4637730429, 35880.4617930726, 36590.63409365872, 36834.447483288306, 37032.814835925645, 35066.29867402689, 35240.295194096485, 35862.28275434425, 36056.63943360533, 36251.0, 27849.860750696116, 28943.855280723463, 32154.517682234316, 32244.0, 32477.675223247465, 24021.148186941715, 24090.51818963646, 24100.276991690276, 24122.638160427257, 24267.0], "value": 20184.155992987915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.75092687899104, 393.616224181423, 394.65270561905527, 405.25837716977935, 424.10302210824113, 14542.781858272121, 20914.6862797058, 21253.93730313484, 21634.134634614635, 21885.343439696793, 21019.0, 21607.56784864302, 22155.224567140154, 22236.444088897784, 22376.440588985282, 5336.252924590551, 5473.370562385317, 5473.616846820724, 5830.5044071254, 5878.823635290927, 5766.1639062335935, 5790.218320526738, 5837.211976383176, 5858.824235272928, 5862.179294898718, 5796.217510636074, 5798.681072541009, 5810.360860305363, 7334.339909408152, 7793.103793063813, 7523.849523009564, 7756.0, 7801.4929029612895, 7826.256505631955, 7828.9822323097915, 7506.0, 7534.982777325101, 7542.69829206831, 7562.395008399315, 7632.580208088553, 29927.700722992708, 30257.69742302593, 30364.54453183204, 30392.0, 30642.38715225683, 2815.1233356030725, 2837.702041285656, 2842.7441530262167, 2883.596296518489, 2923.9122826315242, 16237.431689890796, 16422.260998255108, 16866.578335541588, 17067.57331066721, 18030.36893708727, 1925.2587753714781, 1978.6405749929545, 1988.463114958953, 1991.800819918011, 1999.0804230054193, 139747.0, 142066.0, 163480.0, 172798.1360093204, 177074.0, 21623.45941351479, 22389.776102239095, 23212.0, 23831.92285967102, 24321.0, 40418.0, 40818.122278383504, 41496.58503414987, 41797.58202417937, 43118.353224701656, 11064.170187235828, 11323.263987840764, 11537.769244615061, 11758.823617645741, 11799.823002654966, 7660.578668173304, 9048.276137908952, 9108.726738197865, 9151.17639412456, 9360.694080722807, 9199.77000574991, 11144.888551114547, 11222.551097956153, 11267.0, 11422.771544569063, 3672.7979961102396, 3958.9310886060603, 4163.91804097951, 4188.225178342016, 4195.098053918422, 848.898132224137, 871.1897934920459, 887.6804350433839, 887.9189213429389, 911.5032307392487, 21257.04343304555, 22107.0, 22195.66706499404, 22199.889000554893, 22398.440038999157, 885.3448448148324, 911.4986757283467, 915.1854849184232, 919.1865199298669, 929.0, 10856.185786065918, 11568.537258509734, 11693.824592631117, 11749.177557571058, 11756.882431175749, 745478.0, 757994.0, 758918.0, 764716.0, 772367.0, 98065.0, 101290.0, 108437.0, 155164.12089697848, 155556.0, 831.7380025292014, 985.8521221816785, 992.3153024413276, 1004.5379125602159, 1005.8088963096989, 19897.602047959248, 20632.17471301131, 20829.0, 20930.47673808167, 20954.895225523775, 56735.71632141813, 58318.708406459395, 59806.70096649663, 60548.0, 60624.6968765171, 86126.0, 86229.0, 88249.0, 88351.0, 88625.68245905009, 8312.168783121639, 8412.242898139197, 8421.19998600132, 8602.4188999645, 8744.256738177071, 6666.500012499179, 11629.53481860716, 12741.617751467471, 13678.179309241477, 13708.588742337746, 9478.431294122374, 11239.04468120219, 11339.489722962322, 11609.767804644029, 11611.535538578362, 11197.496112674786, 11344.716382090513, 11404.258723182966, 11455.140864435034, 11687.298762074302, 11566.30602163873, 11613.6515904523, 11705.88294117048, 11719.88280117222, 12025.579104731642, 7108.431325494052, 8529.786755330919, 8591.012033615963, 8733.257673097858, 8880.687216167717, 8180.263776260165, 11203.943980280046, 11311.208215424842, 11722.413879306172, 11830.82253766177], "value": 11405.071528261089, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.2588446931838, 1407.809945657336, 1422.4736847366476, 1424.5299051313064, 1431.4131206205452, 8188.5086894786355, 8593.39846210764, 8601.612927418266, 8607.182317679826, 8611.741647750561, 7459.477836551444, 7750.3799696024325, 7761.45669803114, 8107.797305067376, 8351.415400921938, 2289.6565515172692, 2328.9184878529254, 2333.439974406139, 2334.8832558372096, 2337.4623836517612, 2317.2700599311247, 2344.812415006804, 2353.682252895863, 2357.599208134621, 2357.8821058946983, 2045.8261047810954, 2131.7228760261146, 2232.1294695068937, 2307.6500247355316, 2321.7694621850446, 1752.027624668315, 2123.734533183352, 2321.8374713770045, 2322.7561106083954, 2325.1396983116188, 2269.7843704848015, 2320.524292520029, 2348.1429278313462, 2356.399118224842, 2357.7406485286606, 7216.8917466238045, 8468.237858592694, 8564.528950907697, 8570.700025499078, 8584.442011269248, 4524.389207456984, 4975.577075948549, 5013.89972200554, 5140.33175687162, 5146.356705411824, 3355.728165039092, 3514.841832117561, 3546.2552863898613, 3587.0852932502044, 3596.3886139356373, 1158.5344539157973, 1202.3747651221404, 1205.2105870654734, 1246.4204145072586, 1260.0171865944578, 10841.620543281026, 10916.563337466492, 10938.12495000406, 10997.450127493674, 11004.449777511092, 3832.48261484696, 4187.330027195634, 4406.9559304407185, 4443.555644435531, 4518.728876267434, 8477.0, 8486.0665326814, 8575.271101956403, 8600.311975041981, 8625.266852317498, 4935.7532123393685, 4938.481459446706, 4940.777665005012, 4942.283368911488, 4943.456219815817, 3626.8730594429067, 4266.829326826892, 4425.380446737459, 4620.306953956933, 4766.785494652749, 3813.932099012281, 3851.6533511983494, 3964.5440774311323, 3969.0871099646665, 3979.3235150024566, 1281.557862537423, 1301.6030110816102, 1302.3683513495946, 1312.8381382476578, 1315.3620494060374, 793.3890904003885, 894.6645008121955, 917.5045475443186, 932.9253659707207, 950.5484894674975, 5472.5621950243885, 5737.827865164052, 5770.596058275964, 5802.0, 5933.436323549256, 852.8209076093966, 958.9280803939732, 970.3498655900563, 990.301837204769, 1032.1020711980475, 3637.909052273714, 3675.4486826976167, 3726.869559565402, 3775.905602359963, 3804.600516945736, 9871.50642467888, 9978.052085051908, 10113.292069555207, 10220.080192782685, 10228.437435941094, 10138.949305253427, 10153.695389138338, 10170.033846784543, 10170.694879153638, 10172.237082218715, 7423.517471364344, 7798.727044553413, 7810.531368117818, 7922.405819563441, 7989.840203195903, 5540.168974653834, 5789.9710501447225, 5860.150278209721, 5871.442212989759, 5914.674692891932, 8943.284537236876, 9081.45511269326, 9099.090090990849, 9299.581518831534, 9420.670276540288, 9182.357234993486, 9413.529323533932, 9474.0, 9498.00270971538, 9506.096920792514, 6650.600963942179, 6846.931530684629, 7184.173820010766, 7332.120145582564, 7341.9632901837285, 7494.925050749423, 7922.445428819928, 7983.560904150095, 8064.951556297644, 8065.87901181471, 7055.894161587477, 7119.501634885508, 7139.714411423485, 7182.928170718435, 7277.59973201479, 7039.436845052486, 7042.964785176041, 7049.541779784297, 7068.611226382598, 7115.395191408788, 5077.8730531737, 6365.61806291624, 6493.155889734304, 6495.837604059936, 6496.0580715795, 4249.87250382489, 4904.983435187405, 4962.652614316963, 5020.774065167003, 5145.871353216199, 3824.808759561955, 5021.0, 5075.365579302587, 5143.71709555978, 5157.7679004445645], "value": 4387.942873304312, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.25880474907706, 354.85805677728905, 356.15235738941317, 363.9836207370668, 364.0225993208234, 4849.321095046696, 5220.608454365928, 5262.447443018481, 5302.814401495948, 5330.413654498007, 4506.8873278167985, 4582.679212455129, 4822.8425177957215, 5145.768440420181, 5225.216217567367, 3590.1563132663805, 3723.515942927416, 3954.9802250988705, 3997.8800635980965, 4037.3540233562635, 4062.2281766464425, 4065.1869626074754, 4083.3466645336753, 4086.5504794472586, 4099.3850922361735, 3366.9158271043298, 4063.9390409143884, 4069.470968774055, 4077.0, 4083.203775263825, 3777.0934975605933, 3863.594322596115, 3993.4409182714444, 4050.4936882889638, 4051.250518654044, 3214.5352900069975, 3297.7526685498683, 3514.279572687593, 3520.9471857922154, 3532.91167720809, 4461.486929003141, 5050.772715227787, 5066.265391518246, 5068.670536415121, 5111.1566591512355, 4218.915621687549, 4505.932411013838, 4609.510864133364, 4622.537746225385, 4670.509596492388, 4967.839878550607, 5146.092457761353, 5549.278593782782, 5572.241740338518, 5601.495865372095, 3243.8702451901895, 3305.983470082634, 3802.7338086333966, 3820.178661587744, 3842.654161125512, 5551.168114522238, 5702.54379649627, 5775.422457754233, 5831.3877042910735, 5890.614301208017, 3012.9246768830953, 3290.0, 3799.1831756172555, 3817.7136714746507, 3824.1395685970433, 3343.7659363844296, 3868.6131386861653, 3870.3807390817897, 3894.9221015580097, 3901.356276214393, 4509.887252818706, 4514.480834704051, 4551.362809206714, 4566.607184808665, 4569.54304569547, 5174.534291913746, 5315.309009828775, 5501.184609078994, 5548.861278468071, 5658.207850900877, 1126.4705588373452, 1240.1009268280604, 1240.5161986825146, 1243.7574672938872, 1245.4768997021272, 785.9586048485666, 797.8484088023257, 831.2975535672347, 844.0462277626366, 846.6909578004107, 4500.5823165702695, 4541.613962813198, 4698.95301046992, 4915.852524424273, 5090.516400941905, 5616.887662246814, 5658.660480371191, 5670.376258611549, 5678.858028549319, 5702.144678298206, 4926.679765815211, 5075.746212689351, 5093.8726531837, 5119.232115182678, 5134.2812006319145, 2613.8368426050224, 2625.9889942372324, 2836.957445638317, 2856.2859285178706, 2870.7846911481724, 5640.71796410186, 5664.745086471119, 5668.291463567054, 5680.829575112753, 5685.60200785941, 5070.776471996086, 5124.846254612293, 5493.901219756065, 5604.775808967677, 5626.831195064155, 4833.148442418989, 5151.4590967949325, 5566.832995010156, 5605.691686957175, 5679.166562570331, 4967.776450059684, 5319.601029922848, 5435.83692489226, 5439.864003399946, 5471.8084867029465, 4786.0667169901535, 4803.55018940336, 4857.878553036202, 4922.1632322505975, 5205.8177963772605, 5244.977229440223, 5326.215717734447, 5628.960361404959, 5648.661080335193, 5669.688167150682, 3171.936561268808, 3234.336960922958, 3577.6422357765055, 3612.898066089868, 3675.6875665568728, 4475.641948644035, 4751.881202969954, 5677.886442271214, 5706.629069110661, 5765.423457654201, 4696.835610753607, 5057.165567681292, 5485.259489968803, 5525.950069486785, 5532.280803495681, 5207.609429292894, 5243.921341179809, 5569.0, 5576.442355764391, 5631.971840140773, 4736.8578942631775, 4989.850304490871, 5173.8876141628225, 5343.984642917833, 5366.7048312343195, 5231.3199284092825, 5268.525832675077, 5357.464073711331, 5405.567524605904, 5507.7246137692155, 5395.946040539544, 5404.756785944721, 5425.83722488326, 5426.0, 5464.972675136599], "value": 3988.1149172080986, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.9440044796416, 724.7101159536188, 765.0245936431053, 822.9423940324178, 836.0677844203711, 14798.186099764509, 15596.688066238668, 15621.140837253946, 15630.843691563081, 15656.13891235983, 13356.53252136173, 13969.206178497612, 14246.287685615729, 14385.64035899103, 14429.350679219435, 865.0527672198932, 868.4875923205308, 884.0893879304294, 884.747846863644, 885.3183049052226, 879.5821984557316, 882.2104216726026, 882.8940527136753, 883.6023789294811, 884.1379654836547, 932.6362718539741, 933.0809152984305, 933.8225737109962, 935.4247138010109, 935.4854829843558, 921.8525035994209, 923.6951805904035, 924.1220840201768, 924.5146298193436, 928.5682157796623, 688.8209065642969, 690.837653151509, 693.8126705789459, 694.0907411291224, 694.8957656351537, 13413.597592072254, 13589.252591107484, 14630.853691463162, 15019.474318398912, 15209.467668631545, 12477.625671229787, 13185.0, 13779.724405511834, 13782.586522404345, 13826.516071937434, 11600.593979210771, 11691.298522088617, 11775.352355620438, 11875.703107422298, 11913.166078374517, 3572.9285414291567, 3632.5096112025067, 3665.8350374233223, 3736.7757934524016, 3830.559485659129, 47488.762556187, 88446.0, 104405.47797260965, 105510.94489055088, 105788.0, 10443.477826108665, 10561.735956600993, 10578.52396642153, 10719.678409647722, 10909.236353455182, 22009.11963521473, 22235.332940011504, 22283.777162228493, 22329.665055024187, 22376.55246895053, 7646.120696120018, 7753.689852405953, 7757.7672669819995, 7772.961135194288, 7845.960770196227, 4178.498580170399, 4270.188664153801, 4270.466191726035, 4280.165367753259, 4350.912981740347, 3550.431930891045, 3628.310620982005, 3631.2011357501306, 3655.7753152694145, 3672.2839046386234, 631.908373285871, 632.8860805055134, 637.4581605635173, 650.9909640057891, 652.7062821730241, 667.4393509452084, 675.6216518749516, 684.8323608247925, 692.2350802363417, 731.9341259286583, 9353.158215760614, 9784.266180036526, 9856.606841038305, 10298.021687939634, 10535.63125290611, 686.1457485430572, 695.8434352270699, 702.6486756621689, 703.7325816189917, 706.9964650176717, 4458.687891847604, 4880.31675565414, 4892.363992681, 4900.191468407673, 4902.828401005948, 80788.59605702052, 94710.0, 95687.52156239175, 96000.0, 97488.05023899623, 55892.0, 57339.42660573425, 64918.0, 75404.62297688586, 92033.0, 77507.0, 77965.61017194878, 78185.60907195427, 78733.0, 79260.6036969823, 10516.211284153565, 10755.354678719303, 10834.241603087708, 11030.44847757625, 11030.944845276043, 44642.55357446384, 45616.859578510805, 50021.0, 50676.239856401444, 51884.70288242824, 50011.49988500068, 65509.0, 67219.66390168018, 67359.65280694456, 67791.32208678048, 12725.996924500654, 12847.421866016239, 12952.158109722837, 12961.740765184832, 13211.813337317442, 13879.0, 14162.858371416154, 14243.715125697221, 14383.640408989859, 14690.706185876435, 13154.294299971703, 13451.125676830974, 13507.986900982662, 13616.774779903231, 13843.377048032662, 12154.209976351509, 12942.547010854574, 13078.411471483996, 13586.388612512263, 14008.369623367176, 12346.81479777786, 13175.070035004972, 13359.666008349868, 13387.343183163994, 13650.112742671694, 10615.595075239398, 11125.777484450104, 11291.491882865126, 11315.773684526428, 11456.656300311004, 9393.483358415353, 10244.743881402726, 10506.326603466716, 10843.024127828534, 10938.726531836768], "value": 7414.847375361581, "unit": "score"}], "name": "dromaeo_css", "value": 7454.92056359895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 123.0, 169.0, 146.0, 113.0, 113.0, 113.0, 112.0, 116.0, 113.0], "value": 123.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 107.0, 112.0, 143.0, 109.0, 109.0, 109.0, 107.0, 127.0, 108.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 181.0, 185.0, 184.0, 184.0, 183.0, 186.0, 237.0, 183.0], "value": 189.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 89.0, 61.0, 60.0, 59.0, 58.0, 75.0, 59.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 85.0, 70.0, 68.0, 69.0, 82.0, 68.0, 90.0, 114.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 128.0, 84.0, 88.0, 84.0, 88.0, 85.0, 87.0, 85.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 89.0, 85.0, 87.0, 86.0, 87.0, 87.0, 87.0, 87.0], "value": 86.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 74.0, 89.0, 90.0, 89.0, 56.0, 56.0, 54.0, 58.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 76.0, 67.0, 75.0, 76.0, 68.0, 68.0, 69.0, 70.0, 71.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 87.0, 84.0, 84.0, 83.0, 82.0, 83.0, 87.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 165.0, 145.0, 151.0, 137.0, 140.0, 145.0, 133.0, 195.0, 169.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 228.0, 156.0, 216.0, 226.0, 183.0, 166.0, 168.0, 169.0, 168.0], "value": 188.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 64.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1473.5, "alertThreshold": 2.0}]} 08:56:06 INFO - Return code: 0 08:56:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:56:06 ERROR - # TBPL SUCCESS # 08:56:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:56:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:56:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:56:06 INFO - 2017-02-26 08:56:06.285 screenresolution[1673:17241] starting screenresolution argv=screenresolution get 08:56:06 INFO - 2017-02-26 08:56:06.288 screenresolution[1673:17241] Display 0: 1600x1200x32@60 08:56:06 INFO - 2017-02-26 08:56:06.294 screenresolution[1674:17244] starting screenresolution argv=screenresolution list 08:56:06 INFO - Available Modes on Display 0 08:56:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:56:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:56:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:56:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:56:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:56:06 INFO - Intel Iris: 08:56:06 INFO - Chipset Model: Intel Iris 08:56:06 INFO - Type: GPU 08:56:06 INFO - Bus: Built-In 08:56:06 INFO - VRAM (Dynamic, Max): 1536 MB 08:56:06 INFO - Vendor: Intel (0x8086) 08:56:06 INFO - Device ID: 0x0a2e 08:56:06 INFO - Revision ID: 0x0009 08:56:06 INFO - Displays: 08:56:06 INFO - Display: 08:56:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:56:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:56:06 INFO - Display Serial Number: 1600x1200 60 08:56:06 INFO - Main Display: Yes 08:56:06 INFO - Mirror: Off 08:56:06 INFO - Online: Yes 08:56:06 INFO - Rotation: Supported 08:56:06 INFO - Return code: 0 08:56:06 INFO - Running post-action listener: _resource_record_post_action 08:56:06 INFO - [mozharness: 2017-02-26 16:56:06.548802Z] Finished run-tests step (success) 08:56:06 INFO - Running post-run listener: _resource_record_post_run 08:56:06 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 33774592; Write bytes: 512915456; Read time: 309; Write time: 1753 08:56:06 INFO - TinderboxPrint: CPU usage
53.7% 08:56:06 INFO - TinderboxPrint: I/O read bytes / time
33,774,592 / 309 08:56:06 INFO - TinderboxPrint: I/O write bytes / time
512,915,456 / 1,753 08:56:06 INFO - TinderboxPrint: CPU idle
2,220.2 (46.3%) 08:56:06 INFO - TinderboxPrint: CPU system
961.9 (20.1%) 08:56:06 INFO - TinderboxPrint: CPU user
1,615.6 (33.7%) 08:56:06 INFO - TinderboxPrint: Swap in / out
237,096,960 / 0 08:56:06 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205771264; Write bytes: 203446272; Read time: 15691; Write time: 410 08:56:06 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31652864; Write bytes: 300711936; Read time: 286; Write time: 1306 08:56:07 INFO - Running post-run listener: _upload_blobber_files 08:56:07 INFO - Blob upload gear active. 08:56:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:56:07 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 08:56:07 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'] 08:56:07 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 08:56:07 INFO - (blobuploader) - INFO - Open directory for files ... 08:56:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:56:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:56:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:08 INFO - (blobuploader) - INFO - Done attempting. 08:56:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:56:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:56:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:09 INFO - (blobuploader) - INFO - Done attempting. 08:56:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:56:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:56:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:10 INFO - (blobuploader) - INFO - Done attempting. 08:56:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:56:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:56:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:12 INFO - (blobuploader) - INFO - Done attempting. 08:56:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:56:12 INFO - Return code: 0 08:56:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:56:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:56:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57d50c7de2c1baec23a89eef64629ec8e0bc5bc5a45645745ad08d26a12dab6c25c0fa413dac653c469ac1758bc46daa235466b18411f393a1d0bd4f4746b2b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5549508e3f1cb680c719a857bacaec0ece6984be722b123ef2be59e5117b5a2af79a88e1442d64150ca4b340baa114a29aa6351a60a2f31b0fec1814f2e97dc7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a46a17835b77b29fcd2300e5a9f0947c9b2f6f3d27ff4b8d0fad6a8f758bbbafafb0fadac5c1aadd7f3a6d3732f16a687f4859305f2d61b2e69a79cee11c897a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3103d2c03226416fbc9cbf6d1d946f81f89544169f108debabffa3fa24580b7c94596e35018263476ba4b44a915290d1237e6990d5de4b2c825e546facf5029f"} 08:56:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:56:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:56:12 INFO - Contents: 08:56:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57d50c7de2c1baec23a89eef64629ec8e0bc5bc5a45645745ad08d26a12dab6c25c0fa413dac653c469ac1758bc46daa235466b18411f393a1d0bd4f4746b2b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5549508e3f1cb680c719a857bacaec0ece6984be722b123ef2be59e5117b5a2af79a88e1442d64150ca4b340baa114a29aa6351a60a2f31b0fec1814f2e97dc7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a46a17835b77b29fcd2300e5a9f0947c9b2f6f3d27ff4b8d0fad6a8f758bbbafafb0fadac5c1aadd7f3a6d3732f16a687f4859305f2d61b2e69a79cee11c897a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3103d2c03226416fbc9cbf6d1d946f81f89544169f108debabffa3fa24580b7c94596e35018263476ba4b44a915290d1237e6990d5de4b2c825e546facf5029f"} 08:56:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:56:12 INFO - Copying logs to upload dir... 08:56:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:56:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.434279 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-26 08:56:12.692789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-26 08:56:12.696933) ========= 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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57d50c7de2c1baec23a89eef64629ec8e0bc5bc5a45645745ad08d26a12dab6c25c0fa413dac653c469ac1758bc46daa235466b18411f393a1d0bd4f4746b2b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5549508e3f1cb680c719a857bacaec0ece6984be722b123ef2be59e5117b5a2af79a88e1442d64150ca4b340baa114a29aa6351a60a2f31b0fec1814f2e97dc7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a46a17835b77b29fcd2300e5a9f0947c9b2f6f3d27ff4b8d0fad6a8f758bbbafafb0fadac5c1aadd7f3a6d3732f16a687f4859305f2d61b2e69a79cee11c897a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3103d2c03226416fbc9cbf6d1d946f81f89544169f108debabffa3fa24580b7c94596e35018263476ba4b44a915290d1237e6990d5de4b2c825e546facf5029f"} build_url:https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010950 build_url: 'https://queue.taskcluster.net/v1/task/WsAX7ovLQQyZNII6iMDUHA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57d50c7de2c1baec23a89eef64629ec8e0bc5bc5a45645745ad08d26a12dab6c25c0fa413dac653c469ac1758bc46daa235466b18411f393a1d0bd4f4746b2b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5549508e3f1cb680c719a857bacaec0ece6984be722b123ef2be59e5117b5a2af79a88e1442d64150ca4b340baa114a29aa6351a60a2f31b0fec1814f2e97dc7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a46a17835b77b29fcd2300e5a9f0947c9b2f6f3d27ff4b8d0fad6a8f758bbbafafb0fadac5c1aadd7f3a6d3732f16a687f4859305f2d61b2e69a79cee11c897a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3103d2c03226416fbc9cbf6d1d946f81f89544169f108debabffa3fa24580b7c94596e35018263476ba4b44a915290d1237e6990d5de4b2c825e546facf5029f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-26 08:56:12.732036) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 08:56:12.732803) ========= 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.LzoHHAVDC0/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.aXlpx4lkiV/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005069 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-26 08:56:12.782969) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-26 08:56:12.783382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-26 08:56:12.783852) ========= ========= Total master_lag: 0.20 =========