Back to build
Raw log | Switch to full mode | Login

python -u /b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py --show-path --with-third-party-lib -- python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/swarming/resources/collect_task.py --verbose -o /b/s/w/ir/tmp/t/tmpjZTMxV.json --task-output-dir /b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6 --merge-script /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/swarming/resources/noop_merge.py --merge-script-stdout-file /b/s/w/ir/tmp/t/tmpKiuHUpmerge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpl_Bsca.json -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmpTwxJEg.json in dir /b/s/w/ir/kitchen-workdir: allow_subannotations: False base_name: 'ios_chrome_web_egtests (iPhone X iOS 11.4) on Mac-10.13.6' cmd: ['python', '-u', '/b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py', '--show-path', '--with-third-party-lib', '--', 'python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/swarming/resources/collect_task.py', '--verbose', '-o', '/b/s/w/ir/tmp/t/tmpjZTMxV.json', '--task-output-dir', '/b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6', '--merge-script', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/swarming/resources/noop_merge.py', '--merge-script-stdout-file', '/b/s/w/ir/tmp/t/tmpKiuHUpmerge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpl_Bsca.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', '/b/s/w/ir/tmp/t/tmpTwxJEg.json'] env: {} env_prefixes: {'PATH': '/b/s/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name: 'ios_chrome_web_egtests (iPhone X iOS 11.4) on Mac-10.13.6' nest_level: 0 ok_ret: frozenset([0]) step_test_data: <lambda>(...) trigger_specs: () full environment: Apple_PubSub_Socket_Render: /private/tmp/com.apple.launchd.2Pv7ZuX0UK/Render BOTO_CONFIG: /b/s/w/ir/tmp/gsutil_task/.boto BUILDBUCKET_EXPERIMENTAL: FALSE CIPD_CACHE_DIR: /b/s/cipd_cache/cache CIPD_PROTOCOL: v2 DEVSHELL_CLIENT_PORT: 49242 DOCKER_CONFIG: /b/s/w/ir/tmp/docker_cfg_task DOCKER_TMPDIR: /b/s/w/ir/tmp/docker_tmp_task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /Users/chrome-bot INFRA_GIT_WRAPPER_HOME: /b/s/w/ir/tmp/git_home_task LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8921232458092935056 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/itZ1pJvj/luci_context.479161719 MAC_CHROMIUM_TMPDIR: /b/s/w/ir/tmp/t NO_GCE_CHECK: False PATH: /b/s/w/ir/cache/swarming_client:/b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/opt/local/bin:/opt/local/sbin:/usr/local/sbin:/usr/local/git/bin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin PWD: /b/s/w/ir PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SHELL: /bin/bash SHLVL: 1 SSH_AUTH_SOCK: /private/tmp/com.apple.launchd.TfdzOxDiIG/Listeners SWARMING_BOT_ID: vm140-m9 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 4316a58e64314811 TEMP: /b/s/w/ir/tmp/t TEMPDIR: /b/s/w/ir/tmp/t TMP: /b/s/w/ir/tmp/t TMPDIR: /b/s/w/ir/tmp/t USER: chrome-bot VERSIONER_PYTHON_PREFER_32_BIT: no VERSIONER_PYTHON_VERSION: 2.7 VPYTHON_VIRTUALENV_ROOT: /b/s/w/ir/cache/vpython XPC_FLAGS: 0x0 XPC_SERVICE_NAME: 0 _: /b/s/w/ir/cipd_bin_packages/vpython __CF_USER_TEXT_ENCODING: 0x1F4:0x0:0x0 Set PYTHONPATH: /b/s/w/ir/kitchen-checkout/build/scripts:/b/s/w/ir/kitchen-checkout/build/site_config:/b/s/w/ir/kitchen-checkout/build/third_party:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/s/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/s/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/s/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/s/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/s/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/s/w/ir/kitchen-checkout/build/third_party/jinja2:/b/s/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/s/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/s/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/s/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/s/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/s/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/s/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/s/w/ir/kitchen-checkout/build/third_party/site-packages 2019-02-17 16:23:13,803 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6' 2019-02-17 16:23:13,803 - root: [WARNING] task_output_dir '/b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6' already exists! 2019-02-17 16:23:13,804 - root: [WARNING] task_output_dir existing content: [] 2019-02-17 16:23:13,804 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmpTwxJEg.json -output-dir /b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6 -task-summary-json /b/s/w/ir/tmp/t/tmpl_Bsca.json 4316b30c7467f410: exit 0 [I 2019-02-17 15:54:16] About to install Xcode 10b61 in Xcode.app for ios [03:54:17:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer Device wiped. [03:54:27:INFO] User defaults from command line: [03:54:27:INFO] IDETestRunSpecificationPath = /var/folders/2j/22s2gz0s7hn48k32d47clxf80000gm/T/12A55A02-56B1-419D-96BF-4B14E3283AB4 [03:54:27:INFO] [03:54:27:INFO] Testing started on 'iPhone X' [03:54:27:INFO] 2019-02-17 15:54:27.488 xcodebuild[32147:413535] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [03:54:27:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-exkhipnciwcjdlhatgxotkxhxsbj/Logs/Test/Test-Transient Testing-2019.02.17_15-54-27--0800.xcresult/1_Test/Diagnostics/ios_chrome_web_egtests_module-0583F4D0-6961-41F6-9DD3-62EA253521B3/ios_chrome_web_egtests_module-84B92AC7-1A59-4D8E-88FB-93509B26DB3E/Session-ios_chrome_web_egtests_module-2019-02-17_155427-bWNDyb.log [03:54:27:INFO] 2019-02-17 15:54:27.488 xcodebuild[32147:413511] [MT] IDETestOperationsObserverDebug: (DA550E76-A5A6-4ECA-B5B6-869E9DE61575) Beginning test session ios_chrome_web_egtests_module-DA550E76-A5A6-4ECA-B5B6-869E9DE61575 at 2019-02-17 15:54:27.489 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7ff9bf6c32b0> { [03:54:27:INFO] SimDevice: iPhone X (FE071F08-E6C6-4310-AC90-1DF802358087, iOS 11.4, Shutdown) [03:54:27:INFO] } (11.4 (15F79)) [03:54:51:INFO] dyld: warning: could not load inserted library '/b/s/w/ir/Xcode.app/Contents/Developer/Platforms/iPhoneSimulator.platform/Developer/Library/PrivateFrameworks/IDEBundleInjection.framework/IDEBundleInjection' because image not found [03:54:53:INFO] 2019-02-17 15:54:53.175 ios_chrome_web_egtests[32270:415222] Crash handler setup started. [03:54:53:INFO] 2019-02-17 15:54:53.175 ios_chrome_web_egtests[32270:415222] Crash handler setup completed. [03:54:53:INFO] 2019-02-17 15:54:53.175 ios_chrome_web_egtests[32270:415222] Enabling accessibility for automation on Simulator. [03:54:53:INFO] objc[32270]: Class VCWeakObjectHolder is implemented in both /b/s/w/ir/Xcode.app/Contents/Developer/Platforms/iPhoneOS.platform/Developer/Library/CoreSimulator/Profiles/Runtimes/iOS 11.4.simruntime/Contents/Resources/RuntimeRoot/System/Library/PrivateFrameworks/AVConference.framework/Frameworks/ViceroyTrace.framework/ViceroyTrace (0x13d5b04d0) and /b/s/w/ir/Xcode.app/Contents/Developer/Platforms/iPhoneOS.platform/Developer/Library/CoreSimulator/Profiles/Runtimes/iOS 11.4.simruntime/Contents/Resources/RuntimeRoot/System/Library/PrivateFrameworks/AVConference.framework/AVConference (0x13d3c6e38). One of the two will be used. Which one is undefined. [03:54:56:INFO] 2019-02-17 15:54:56.897 ios_chrome_web_egtests[32270:415222] Unbalanced calls to begin/end appearance transitions for <TabGridViewController: 0x7ff1298b4e00>. [03:54:57:INFO] [0217/155457.660741:WARNING:leveldb_database.cc(111)] Unable to open /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/FE071F08-E6C6-4310-AC90-1DF802358087/data/Containers/Data/Application/E3E06AA0-EEA5-4E96-835B-D3EFDB6D8D4C/Library/Application Support/Chromium/Default/shared_proto_db: Invalid argument: /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/FE071F08-E6C6-4310-AC90-1DF802358087/data/Containers/Data/Application/E3E06AA0-EEA5-4E96-835B-D3EFDB6D8D4C/Library/Application Support/Chromium/Default/shared_proto_db: does not exist (create_if_missing is false) [03:55:03:INFO] Test Suite 'All tests' started at 2019-02-17 15:55:03.986 [03:55:03:INFO] Test Suite 'ios_chrome_web_egtests.app' started at 2019-02-17 15:55:03.987 [03:55:03:INFO] Test Suite 'BrowsingPreventDefaultTestCase' started at 2019-02-17 15:55:03.987 [03:55:03:INFO] [0217/155503.996041:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:55:05:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesStopPropagation]' started. [03:55:08:INFO] [0217/155508.121461:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:55:11:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesStopPropagation]' passed (5.149 seconds). [03:55:11:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesTargetBlank]' started. [03:55:16:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesTargetBlank]' passed (4.988 seconds). [03:55:16:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesWindowOpen]' started. [03:55:21:INFO] Test Case '-[BrowsingPreventDefaultTestCase testPreventDefaultOverridesWindowOpen]' passed (5.930 seconds). [03:55:21:INFO] Test Suite 'BrowsingPreventDefaultTestCase' passed at 2019-02-17 15:55:21.965. [03:55:21:INFO] Executed 3 tests, with 0 failures (0 unexpected) in 16.067 (17.978) seconds [03:55:21:INFO] Test Suite 'BrowsingTestCase' started at 2019-02-17 15:55:21.966 [03:55:21:INFO] [0217/155521.967431:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:55:21:INFO] Test Case '-[BrowsingTestCase testBrowsingJavaScriptBasedNavigation]' started. [03:55:23:INFO] [0217/155523.909743:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:55:29:INFO] Test Case '-[BrowsingTestCase testBrowsingJavaScriptBasedNavigation]' passed (7.371 seconds). [03:55:29:INFO] Test Case '-[BrowsingTestCase testBrowsingStopPropagation]' started. [03:55:35:INFO] Test Case '-[BrowsingTestCase testBrowsingStopPropagation]' passed (5.970 seconds). [03:55:35:INFO] Test Case '-[BrowsingTestCase testBrowsingStopPropagationRelativePath]' started. [03:55:41:INFO] Test Case '-[BrowsingTestCase testBrowsingStopPropagationRelativePath]' passed (6.040 seconds). [03:55:41:INFO] Test Case '-[BrowsingTestCase testBrowsingTabTitleSetFromScript]' started. [03:55:43:INFO] 2019-02-17 15:55:43.071 ios_chrome_web_egtests[32270:415222] -- Earl Grey Test Skipped -- Tab Title not displayed on handset. [03:55:44:INFO] Test Case '-[BrowsingTestCase testBrowsingTabTitleSetFromScript]' passed (3.629 seconds). [03:55:44:INFO] Test Case '-[BrowsingTestCase testBrowsingTabTitleSetFromURL]' started. [03:55:46:INFO] 2019-02-17 15:55:46.771 ios_chrome_web_egtests[32270:415222] -- Earl Grey Test Skipped -- Tab Title not displayed on handset. [03:55:48:INFO] Test Case '-[BrowsingTestCase testBrowsingTabTitleSetFromURL]' passed (3.699 seconds). [03:55:48:INFO] Test Case '-[BrowsingTestCase testBrowsingUserJavaScriptNavigation]' started. [03:55:53:INFO] 2019-02-17 15:55:53.249 ios_chrome_web_egtests[32270:415222] Attempting to type key j. [03:55:53:INFO] 2019-02-17 15:55:53.253 ios_chrome_web_egtests[32270:415222] Tapping on key: j. [03:55:53:INFO] 2019-02-17 15:55:53.374 ios_chrome_web_egtests[32270:415222] Attempting to type key a. [03:55:53:INFO] 2019-02-17 15:55:53.375 ios_chrome_web_egtests[32270:415222] Tapping on key: a. [03:55:53:INFO] 2019-02-17 15:55:53.457 ios_chrome_web_egtests[32270:415222] Attempting to type key v. [03:55:53:INFO] 2019-02-17 15:55:53.460 ios_chrome_web_egtests[32270:415222] Tapping on key: v. [03:55:53:INFO] 2019-02-17 15:55:53.544 ios_chrome_web_egtests[32270:415222] Attempting to type key a. [03:55:53:INFO] 2019-02-17 15:55:53.545 ios_chrome_web_egtests[32270:415222] Tapping on key: a. [03:55:53:INFO] 2019-02-17 15:55:53.633 ios_chrome_web_egtests[32270:415222] Attempting to type key s. [03:55:53:INFO] 2019-02-17 15:55:53.634 ios_chrome_web_egtests[32270:415222] Tapping on key: s. [03:55:53:INFO] 2019-02-17 15:55:53.696 ios_chrome_web_egtests[32270:415222] Attempting to type key c. [03:55:53:INFO] 2019-02-17 15:55:53.697 ios_chrome_web_egtests[32270:415222] Tapping on key: c. [03:55:53:INFO] 2019-02-17 15:55:53.764 ios_chrome_web_egtests[32270:415222] Attempting to type key r. [03:55:53:INFO] 2019-02-17 15:55:53.764 ios_chrome_web_egtests[32270:415222] Tapping on key: r. [03:55:53:INFO] 2019-02-17 15:55:53.843 ios_chrome_web_egtests[32270:415222] Attempting to type key i. [03:55:53:INFO] 2019-02-17 15:55:53.844 ios_chrome_web_egtests[32270:415222] Tapping on key: i. [03:55:53:INFO] 2019-02-17 15:55:53.910 ios_chrome_web_egtests[32270:415222] Attempting to type key p. [03:55:53:INFO] 2019-02-17 15:55:53.911 ios_chrome_web_egtests[32270:415222] Tapping on key: p. [03:55:53:INFO] 2019-02-17 15:55:53.979 ios_chrome_web_egtests[32270:415222] Attempting to type key t. [03:55:53:INFO] 2019-02-17 15:55:53.979 ios_chrome_web_egtests[32270:415222] Tapping on key: t. [03:55:54:INFO] 2019-02-17 15:55:54.055 ios_chrome_web_egtests[32270:415222] Attempting to type key :. [03:55:54:INFO] 2019-02-17 15:55:54.156 ios_chrome_web_egtests[32270:415222] Tapping on key: more, numbers. [03:55:54:INFO] 2019-02-17 15:55:54.227 ios_chrome_web_egtests[32270:415222] Tapping on key: :. [03:55:54:INFO] 2019-02-17 15:55:54.291 ios_chrome_web_egtests[32270:415222] Attempting to type key w. [03:55:54:INFO] 2019-02-17 15:55:54.596 ios_chrome_web_egtests[32270:415222] Tapping on key: more, letters. [03:55:54:INFO] 2019-02-17 15:55:54.648 ios_chrome_web_egtests[32270:415222] Tapping on key: w. [03:55:54:INFO] 2019-02-17 15:55:54.701 ios_chrome_web_egtests[32270:415222] Attempting to type key i. [03:55:54:INFO] 2019-02-17 15:55:54.703 ios_chrome_web_egtests[32270:415222] Tapping on key: i. [03:55:54:INFO] 2019-02-17 15:55:54.754 ios_chrome_web_egtests[32270:415222] Attempting to type key n. [03:55:54:INFO] 2019-02-17 15:55:54.755 ios_chrome_web_egtests[32270:415222] Tapping on key: n. [03:55:54:INFO] 2019-02-17 15:55:54.807 ios_chrome_web_egtests[32270:415222] Attempting to type key d. [03:55:54:INFO] 2019-02-17 15:55:54.807 ios_chrome_web_egtests[32270:415222] Tapping on key: d. [03:55:54:INFO] 2019-02-17 15:55:54.858 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:55:54:INFO] 2019-02-17 15:55:54.858 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:55:54:INFO] 2019-02-17 15:55:54.910 ios_chrome_web_egtests[32270:415222] Attempting to type key w. [03:55:54:INFO] 2019-02-17 15:55:54.910 ios_chrome_web_egtests[32270:415222] Tapping on key: w. [03:55:54:INFO] 2019-02-17 15:55:54.961 ios_chrome_web_egtests[32270:415222] Attempting to type key .. [03:55:54:INFO] 2019-02-17 15:55:54.962 ios_chrome_web_egtests[32270:415222] Tapping on key: .. [03:55:55:INFO] 2019-02-17 15:55:55.024 ios_chrome_web_egtests[32270:415222] Attempting to type key l. [03:55:55:INFO] 2019-02-17 15:55:55.024 ios_chrome_web_egtests[32270:415222] Tapping on key: l. [03:55:55:INFO] 2019-02-17 15:55:55.078 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:55:55:INFO] 2019-02-17 15:55:55.078 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:55:55:INFO] 2019-02-17 15:55:55.129 ios_chrome_web_egtests[32270:415222] Attempting to type key c. [03:55:55:INFO] 2019-02-17 15:55:55.130 ios_chrome_web_egtests[32270:415222] Tapping on key: c. [03:55:55:INFO] 2019-02-17 15:55:55.181 ios_chrome_web_egtests[32270:415222] Attempting to type key a. [03:55:55:INFO] 2019-02-17 15:55:55.182 ios_chrome_web_egtests[32270:415222] Tapping on key: a. [03:55:55:INFO] 2019-02-17 15:55:55.234 ios_chrome_web_egtests[32270:415222] Attempting to type key t. [03:55:55:INFO] 2019-02-17 15:55:55.234 ios_chrome_web_egtests[32270:415222] Tapping on key: t. [03:55:55:INFO] 2019-02-17 15:55:55.286 ios_chrome_web_egtests[32270:415222] Attempting to type key i. [03:55:55:INFO] 2019-02-17 15:55:55.286 ios_chrome_web_egtests[32270:415222] Tapping on key: i. [03:55:55:INFO] 2019-02-17 15:55:55.338 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:55:55:INFO] 2019-02-17 15:55:55.339 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:55:55:INFO] 2019-02-17 15:55:55.390 ios_chrome_web_egtests[32270:415222] Attempting to type key n. [03:55:55:INFO] 2019-02-17 15:55:55.391 ios_chrome_web_egtests[32270:415222] Tapping on key: n. [03:55:55:INFO] 2019-02-17 15:55:55.443 ios_chrome_web_egtests[32270:415222] Attempting to type key =. [03:55:55:INFO] 2019-02-17 15:55:55.546 ios_chrome_web_egtests[32270:415222] Tapping on key: more, numbers. [03:55:55:INFO] 2019-02-17 15:55:55.699 ios_chrome_web_egtests[32270:415222] Tapping on key: more, symbols. [03:55:55:INFO] 2019-02-17 15:55:55.769 ios_chrome_web_egtests[32270:415222] Tapping on key: =. [03:55:55:INFO] 2019-02-17 15:55:55.822 ios_chrome_web_egtests[32270:415222] Attempting to type key '. [03:55:55:INFO] 2019-02-17 15:55:55.825 ios_chrome_web_egtests[32270:415222] Tapping on key: '. [03:55:55:INFO] 2019-02-17 15:55:55.889 ios_chrome_web_egtests[32270:415222] Attempting to type key h. [03:55:55:INFO] 2019-02-17 15:55:55.892 ios_chrome_web_egtests[32270:415222] Tapping on key: h. [03:55:55:INFO] 2019-02-17 15:55:55.947 ios_chrome_web_egtests[32270:415222] Attempting to type key t. [03:55:55:INFO] 2019-02-17 15:55:55.948 ios_chrome_web_egtests[32270:415222] Tapping on key: t. [03:55:56:INFO] 2019-02-17 15:55:56.000 ios_chrome_web_egtests[32270:415222] Attempting to type key t. [03:55:56:INFO] 2019-02-17 15:55:56.001 ios_chrome_web_egtests[32270:415222] Tapping on key: t. [03:55:56:INFO] 2019-02-17 15:55:56.052 ios_chrome_web_egtests[32270:415222] Attempting to type key p. [03:55:56:INFO] 2019-02-17 15:55:56.052 ios_chrome_web_egtests[32270:415222] Tapping on key: p. [03:55:56:INFO] 2019-02-17 15:55:56.103 ios_chrome_web_egtests[32270:415222] Attempting to type key :. [03:55:56:INFO] 2019-02-17 15:55:56.205 ios_chrome_web_egtests[32270:415222] Tapping on key: more, numbers. [03:55:56:INFO] 2019-02-17 15:55:56.257 ios_chrome_web_egtests[32270:415222] Tapping on key: :. [03:55:56:INFO] 2019-02-17 15:55:56.319 ios_chrome_web_egtests[32270:415222] Attempting to type key /. [03:55:56:INFO] 2019-02-17 15:55:56.320 ios_chrome_web_egtests[32270:415222] Tapping on key: /. [03:55:56:INFO] 2019-02-17 15:55:56.373 ios_chrome_web_egtests[32270:415222] Attempting to type key /. [03:55:56:INFO] 2019-02-17 15:55:56.374 ios_chrome_web_egtests[32270:415222] Tapping on key: /. [03:55:56:INFO] 2019-02-17 15:55:56.425 ios_chrome_web_egtests[32270:415222] Attempting to type key 1. [03:55:56:INFO] 2019-02-17 15:55:56.425 ios_chrome_web_egtests[32270:415222] Tapping on key: 1. [03:55:56:INFO] 2019-02-17 15:55:56.478 ios_chrome_web_egtests[32270:415222] Attempting to type key 2. [03:55:56:INFO] 2019-02-17 15:55:56.478 ios_chrome_web_egtests[32270:415222] Tapping on key: 2. [03:55:56:INFO] 2019-02-17 15:55:56.530 ios_chrome_web_egtests[32270:415222] Attempting to type key 7. [03:55:56:INFO] 2019-02-17 15:55:56.531 ios_chrome_web_egtests[32270:415222] Tapping on key: 7. [03:55:56:INFO] 2019-02-17 15:55:56.584 ios_chrome_web_egtests[32270:415222] Attempting to type key .. [03:55:56:INFO] 2019-02-17 15:55:56.586 ios_chrome_web_egtests[32270:415222] Tapping on key: .. [03:55:56:INFO] 2019-02-17 15:55:56.639 ios_chrome_web_egtests[32270:415222] Attempting to type key 0. [03:55:56:INFO] 2019-02-17 15:55:56.640 ios_chrome_web_egtests[32270:415222] Tapping on key: 0. [03:55:56:INFO] 2019-02-17 15:55:56.692 ios_chrome_web_egtests[32270:415222] Attempting to type key .. [03:55:56:INFO] 2019-02-17 15:55:56.693 ios_chrome_web_egtests[32270:415222] Tapping on key: .. [03:55:56:INFO] 2019-02-17 15:55:56.747 ios_chrome_web_egtests[32270:415222] Attempting to type key 0. [03:55:56:INFO] 2019-02-17 15:55:56.748 ios_chrome_web_egtests[32270:415222] Tapping on key: 0. [03:55:56:INFO] 2019-02-17 15:55:56.801 ios_chrome_web_egtests[32270:415222] Attempting to type key .. [03:55:56:INFO] 2019-02-17 15:55:56.803 ios_chrome_web_egtests[32270:415222] Tapping on key: .. [03:55:56:INFO] 2019-02-17 15:55:56.859 ios_chrome_web_egtests[32270:415222] Attempting to type key 1. [03:55:56:INFO] 2019-02-17 15:55:56.860 ios_chrome_web_egtests[32270:415222] Tapping on key: 1. [03:55:56:INFO] 2019-02-17 15:55:56.912 ios_chrome_web_egtests[32270:415222] Attempting to type key :. [03:55:56:INFO] 2019-02-17 15:55:56.912 ios_chrome_web_egtests[32270:415222] Tapping on key: :. [03:55:56:INFO] 2019-02-17 15:55:56.971 ios_chrome_web_egtests[32270:415222] Attempting to type key 5. [03:55:56:INFO] 2019-02-17 15:55:56.971 ios_chrome_web_egtests[32270:415222] Tapping on key: 5. [03:55:57:INFO] 2019-02-17 15:55:57.026 ios_chrome_web_egtests[32270:415222] Attempting to type key 7. [03:55:57:INFO] 2019-02-17 15:55:57.026 ios_chrome_web_egtests[32270:415222] Tapping on key: 7. [03:55:57:INFO] 2019-02-17 15:55:57.079 ios_chrome_web_egtests[32270:415222] Attempting to type key 2. [03:55:57:INFO] 2019-02-17 15:55:57.079 ios_chrome_web_egtests[32270:415222] Tapping on key: 2. [03:55:57:INFO] 2019-02-17 15:55:57.133 ios_chrome_web_egtests[32270:415222] Attempting to type key 6. [03:55:57:INFO] 2019-02-17 15:55:57.134 ios_chrome_web_egtests[32270:415222] Tapping on key: 6. [03:55:57:INFO] 2019-02-17 15:55:57.187 ios_chrome_web_egtests[32270:415222] Attempting to type key 1. [03:55:57:INFO] 2019-02-17 15:55:57.188 ios_chrome_web_egtests[32270:415222] Tapping on key: 1. [03:55:57:INFO] 2019-02-17 15:55:57.240 ios_chrome_web_egtests[32270:415222] Attempting to type key /. [03:55:57:INFO] 2019-02-17 15:55:57.241 ios_chrome_web_egtests[32270:415222] Tapping on key: /. [03:55:57:INFO] 2019-02-17 15:55:57.294 ios_chrome_web_egtests[32270:415222] Attempting to type key t. [03:55:57:INFO] 2019-02-17 15:55:57.598 ios_chrome_web_egtests[32270:415222] Tapping on key: more, letters. [03:55:57:INFO] 2019-02-17 15:55:57.650 ios_chrome_web_egtests[32270:415222] Tapping on key: t. [03:55:57:INFO] 2019-02-17 15:55:57.703 ios_chrome_web_egtests[32270:415222] Attempting to type key a. [03:55:57:INFO] 2019-02-17 15:55:57.704 ios_chrome_web_egtests[32270:415222] Tapping on key: a. [03:55:57:INFO] 2019-02-17 15:55:57.758 ios_chrome_web_egtests[32270:415222] Attempting to type key r. [03:55:57:INFO] 2019-02-17 15:55:57.758 ios_chrome_web_egtests[32270:415222] Tapping on key: r. [03:55:57:INFO] 2019-02-17 15:55:57.810 ios_chrome_web_egtests[32270:415222] Attempting to type key g. [03:55:57:INFO] 2019-02-17 15:55:57.811 ios_chrome_web_egtests[32270:415222] Tapping on key: g. [03:55:57:INFO] 2019-02-17 15:55:57.865 ios_chrome_web_egtests[32270:415222] Attempting to type key e. [03:55:57:INFO] 2019-02-17 15:55:57.866 ios_chrome_web_egtests[32270:415222] Tapping on key: e. [03:55:57:INFO] 2019-02-17 15:55:57.920 ios_chrome_web_egtests[32270:415222] Attempting to type key t. [03:55:57:INFO] 2019-02-17 15:55:57.921 ios_chrome_web_egtests[32270:415222] Tapping on key: t. [03:55:57:INFO] 2019-02-17 15:55:57.976 ios_chrome_web_egtests[32270:415222] Attempting to type key p. [03:55:57:INFO] 2019-02-17 15:55:57.976 ios_chrome_web_egtests[32270:415222] Tapping on key: p. [03:55:58:INFO] 2019-02-17 15:55:58.033 ios_chrome_web_egtests[32270:415222] Attempting to type key a. [03:55:58:INFO] 2019-02-17 15:55:58.034 ios_chrome_web_egtests[32270:415222] Tapping on key: a. [03:55:58:INFO] 2019-02-17 15:55:58.092 ios_chrome_web_egtests[32270:415222] Attempting to type key g. [03:55:58:INFO] 2019-02-17 15:55:58.093 ios_chrome_web_egtests[32270:415222] Tapping on key: g. [03:55:58:INFO] 2019-02-17 15:55:58.150 ios_chrome_web_egtests[32270:415222] Attempting to type key e. [03:55:58:INFO] 2019-02-17 15:55:58.150 ios_chrome_web_egtests[32270:415222] Tapping on key: e. [03:55:58:INFO] 2019-02-17 15:55:58.209 ios_chrome_web_egtests[32270:415222] Attempting to type key /. [03:55:58:INFO] 2019-02-17 15:55:58.311 ios_chrome_web_egtests[32270:415222] Tapping on key: more, numbers. [03:55:58:INFO] 2019-02-17 15:55:58.363 ios_chrome_web_egtests[32270:415222] Tapping on key: /. [03:55:58:INFO] 2019-02-17 15:55:58.425 ios_chrome_web_egtests[32270:415222] Attempting to type key '. [03:55:58:INFO] 2019-02-17 15:55:58.427 ios_chrome_web_egtests[32270:415222] Tapping on key: '. [03:56:03:INFO] Test Case '-[BrowsingTestCase testBrowsingUserJavaScriptNavigation]' passed (14.733 seconds). [03:56:03:INFO] Test Case '-[BrowsingTestCase testBrowsingUserJavaScriptWithoutNavigation]' started. [03:56:08:INFO] 2019-02-17 15:56:08.638 ios_chrome_web_egtests[32270:415222] Attempting to type key j. [03:56:08:INFO] 2019-02-17 15:56:08.640 ios_chrome_web_egtests[32270:415222] Tapping on key: j. [03:56:08:INFO] 2019-02-17 15:56:08.722 ios_chrome_web_egtests[32270:415222] Attempting to type key a. [03:56:08:INFO] 2019-02-17 15:56:08.722 ios_chrome_web_egtests[32270:415222] Tapping on key: a. [03:56:08:INFO] 2019-02-17 15:56:08.809 ios_chrome_web_egtests[32270:415222] Attempting to type key v. [03:56:08:INFO] 2019-02-17 15:56:08.811 ios_chrome_web_egtests[32270:415222] Tapping on key: v. [03:56:08:INFO] 2019-02-17 15:56:08.884 ios_chrome_web_egtests[32270:415222] Attempting to type key a. [03:56:08:INFO] 2019-02-17 15:56:08.885 ios_chrome_web_egtests[32270:415222] Tapping on key: a. [03:56:08:INFO] 2019-02-17 15:56:08.953 ios_chrome_web_egtests[32270:415222] Attempting to type key s. [03:56:08:INFO] 2019-02-17 15:56:08.954 ios_chrome_web_egtests[32270:415222] Tapping on key: s. [03:56:09:INFO] 2019-02-17 15:56:09.028 ios_chrome_web_egtests[32270:415222] Attempting to type key c. [03:56:09:INFO] 2019-02-17 15:56:09.029 ios_chrome_web_egtests[32270:415222] Tapping on key: c. [03:56:09:INFO] 2019-02-17 15:56:09.104 ios_chrome_web_egtests[32270:415222] Attempting to type key r. [03:56:09:INFO] 2019-02-17 15:56:09.104 ios_chrome_web_egtests[32270:415222] Tapping on key: r. [03:56:09:INFO] 2019-02-17 15:56:09.172 ios_chrome_web_egtests[32270:415222] Attempting to type key i. [03:56:09:INFO] 2019-02-17 15:56:09.173 ios_chrome_web_egtests[32270:415222] Tapping on key: i. [03:56:09:INFO] 2019-02-17 15:56:09.240 ios_chrome_web_egtests[32270:415222] Attempting to type key p. [03:56:09:INFO] 2019-02-17 15:56:09.240 ios_chrome_web_egtests[32270:415222] Tapping on key: p. [03:56:09:INFO] 2019-02-17 15:56:09.307 ios_chrome_web_egtests[32270:415222] Attempting to type key t. [03:56:09:INFO] 2019-02-17 15:56:09.307 ios_chrome_web_egtests[32270:415222] Tapping on key: t. [03:56:09:INFO] 2019-02-17 15:56:09.372 ios_chrome_web_egtests[32270:415222] Attempting to type key :. [03:56:09:INFO] 2019-02-17 15:56:09.474 ios_chrome_web_egtests[32270:415222] Tapping on key: more, numbers. [03:56:09:INFO] 2019-02-17 15:56:09.528 ios_chrome_web_egtests[32270:415222] Tapping on key: :. [03:56:09:INFO] 2019-02-17 15:56:09.592 ios_chrome_web_egtests[32270:415222] Attempting to type key d. [03:56:09:INFO] 2019-02-17 15:56:09.895 ios_chrome_web_egtests[32270:415222] Tapping on key: more, letters. [03:56:09:INFO] 2019-02-17 15:56:09.948 ios_chrome_web_egtests[32270:415222] Tapping on key: d. [03:56:10:INFO] 2019-02-17 15:56:10.002 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:56:10:INFO] 2019-02-17 15:56:10.002 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:56:10:INFO] 2019-02-17 15:56:10.054 ios_chrome_web_egtests[32270:415222] Attempting to type key c. [03:56:10:INFO] 2019-02-17 15:56:10.055 ios_chrome_web_egtests[32270:415222] Tapping on key: c. [03:56:10:INFO] 2019-02-17 15:56:10.107 ios_chrome_web_egtests[32270:415222] Attempting to type key u. [03:56:10:INFO] 2019-02-17 15:56:10.108 ios_chrome_web_egtests[32270:415222] Tapping on key: u. [03:56:10:INFO] 2019-02-17 15:56:10.159 ios_chrome_web_egtests[32270:415222] Attempting to type key m. [03:56:10:INFO] 2019-02-17 15:56:10.160 ios_chrome_web_egtests[32270:415222] Tapping on key: m. [03:56:10:INFO] 2019-02-17 15:56:10.214 ios_chrome_web_egtests[32270:415222] Attempting to type key e. [03:56:10:INFO] 2019-02-17 15:56:10.214 ios_chrome_web_egtests[32270:415222] Tapping on key: e. [03:56:10:INFO] 2019-02-17 15:56:10.265 ios_chrome_web_egtests[32270:415222] Attempting to type key n. [03:56:10:INFO] 2019-02-17 15:56:10.267 ios_chrome_web_egtests[32270:415222] Tapping on key: n. [03:56:10:INFO] 2019-02-17 15:56:10.319 ios_chrome_web_egtests[32270:415222] Attempting to type key t. [03:56:10:INFO] 2019-02-17 15:56:10.320 ios_chrome_web_egtests[32270:415222] Tapping on key: t. [03:56:10:INFO] 2019-02-17 15:56:10.371 ios_chrome_web_egtests[32270:415222] Attempting to type key .. [03:56:10:INFO] 2019-02-17 15:56:10.372 ios_chrome_web_egtests[32270:415222] Tapping on key: .. [03:56:10:INFO] 2019-02-17 15:56:10.435 ios_chrome_web_egtests[32270:415222] Attempting to type key w. [03:56:10:INFO] 2019-02-17 15:56:10.436 ios_chrome_web_egtests[32270:415222] Tapping on key: w. [03:56:10:INFO] 2019-02-17 15:56:10.488 ios_chrome_web_egtests[32270:415222] Attempting to type key r. [03:56:10:INFO] 2019-02-17 15:56:10.489 ios_chrome_web_egtests[32270:415222] Tapping on key: r. [03:56:10:INFO] 2019-02-17 15:56:10.540 ios_chrome_web_egtests[32270:415222] Attempting to type key i. [03:56:10:INFO] 2019-02-17 15:56:10.540 ios_chrome_web_egtests[32270:415222] Tapping on key: i. [03:56:10:INFO] 2019-02-17 15:56:10.591 ios_chrome_web_egtests[32270:415222] Attempting to type key t. [03:56:10:INFO] 2019-02-17 15:56:10.591 ios_chrome_web_egtests[32270:415222] Tapping on key: t. [03:56:10:INFO] 2019-02-17 15:56:10.644 ios_chrome_web_egtests[32270:415222] Attempting to type key e. [03:56:10:INFO] 2019-02-17 15:56:10.644 ios_chrome_web_egtests[32270:415222] Tapping on key: e. [03:56:10:INFO] 2019-02-17 15:56:10.696 ios_chrome_web_egtests[32270:415222] Attempting to type key (. [03:56:10:INFO] 2019-02-17 15:56:10.799 ios_chrome_web_egtests[32270:415222] Tapping on key: more, numbers. [03:56:10:INFO] 2019-02-17 15:56:10.851 ios_chrome_web_egtests[32270:415222] Tapping on key: (. [03:56:10:INFO] 2019-02-17 15:56:10.904 ios_chrome_web_egtests[32270:415222] Attempting to type key '. [03:56:10:INFO] 2019-02-17 15:56:10.906 ios_chrome_web_egtests[32270:415222] Tapping on key: '. [03:56:10:INFO] 2019-02-17 15:56:10.967 ios_chrome_web_egtests[32270:415222] Attempting to type key f. [03:56:10:INFO] 2019-02-17 15:56:10.969 ios_chrome_web_egtests[32270:415222] Tapping on key: f. [03:56:11:INFO] 2019-02-17 15:56:11.021 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:56:11:INFO] 2019-02-17 15:56:11.022 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:56:11:INFO] 2019-02-17 15:56:11.074 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:56:11:INFO] 2019-02-17 15:56:11.074 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:56:11:INFO] 2019-02-17 15:56:11.125 ios_chrome_web_egtests[32270:415222] Attempting to type key '. [03:56:11:INFO] 2019-02-17 15:56:11.226 ios_chrome_web_egtests[32270:415222] Tapping on key: more, numbers. [03:56:11:INFO] 2019-02-17 15:56:11.280 ios_chrome_web_egtests[32270:415222] Tapping on key: '. [03:56:11:INFO] 2019-02-17 15:56:11.346 ios_chrome_web_egtests[32270:415222] Attempting to type key ). [03:56:11:INFO] 2019-02-17 15:56:11.447 ios_chrome_web_egtests[32270:415222] Tapping on key: more, numbers. [03:56:11:INFO] 2019-02-17 15:56:11.500 ios_chrome_web_egtests[32270:415222] Tapping on key: ). [03:56:11:INFO] 2019-02-17 15:56:11.571 ios_chrome_web_egtests[32270:415222] Attempting to type key [03:56:11:INFO] . [03:56:11:INFO] 2019-02-17 15:56:11.573 ios_chrome_web_egtests[32270:415222] Tapping on key: Go. [03:56:16:INFO] Test Case '-[BrowsingTestCase testBrowsingUserJavaScriptWithoutNavigation]' passed (13.002 seconds). [03:56:16:INFO] Test Case '-[BrowsingTestCase testBrowsingWindowDataLinkScriptRedirect]' started. [03:56:22:INFO] Test Case '-[BrowsingTestCase testBrowsingWindowDataLinkScriptRedirect]' passed (6.158 seconds). [03:56:22:INFO] Test Case '-[BrowsingTestCase testPDFLoadTitle]' started. [03:56:24:INFO] 2019-02-17 15:56:24.388 ios_chrome_web_egtests[32270:415222] -- Earl Grey Test Skipped -- Tab Title not displayed on handset. [03:56:26:INFO] Test Case '-[BrowsingTestCase testPDFLoadTitle]' passed (3.733 seconds). [03:56:26:INFO] Test Case '-[BrowsingTestCase testReload]' started. [03:56:34:INFO] Test Case '-[BrowsingTestCase testReload]' passed (8.397 seconds). [03:56:34:INFO] Test Case '-[BrowsingTestCase testTapLinkWithWebUIURL]' started. [03:56:39:INFO] Test Case '-[BrowsingTestCase testTapLinkWithWebUIURL]' passed (4.991 seconds). [03:56:39:INFO] Test Suite 'BrowsingTestCase' passed at 2019-02-17 15:56:39.698. [03:56:39:INFO] Executed 11 tests, with 0 failures (0 unexpected) in 77.722 (77.732) seconds [03:56:39:INFO] Test Suite 'CacheTestCase' started at 2019-02-17 15:56:39.699 [03:56:39:INFO] [0217/155639.699837:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:56:39:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnNavigateBackAndPageReload]' started. [03:56:41:INFO] 2019-02-17 15:56:41.516 ios_chrome_web_egtests[32270:415222] -- Earl Grey Test Disabled -- Disabled on iOS 10.3.1 and afterwards. [03:56:43:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnNavigateBackAndPageReload]' passed (3.740 seconds). [03:56:43:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnOpenNewTab]' started. [03:56:45:INFO] [0217/155645.475497:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:56:50:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnOpenNewTab]' passed (7.156 seconds). [03:56:50:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnSelectOmniboxSuggestion]' started. [03:56:54:INFO] 2019-02-17 15:56:54.932 ios_chrome_web_egtests[32270:415222] Attempting to type key c. [03:56:54:INFO] 2019-02-17 15:56:54.933 ios_chrome_web_egtests[32270:415222] Tapping on key: c. [03:56:55:INFO] 2019-02-17 15:56:55.006 ios_chrome_web_egtests[32270:415222] Attempting to type key a. [03:56:55:INFO] 2019-02-17 15:56:55.007 ios_chrome_web_egtests[32270:415222] Tapping on key: a. [03:56:55:INFO] 2019-02-17 15:56:55.073 ios_chrome_web_egtests[32270:415222] Attempting to type key c. [03:56:55:INFO] 2019-02-17 15:56:55.074 ios_chrome_web_egtests[32270:415222] Tapping on key: c. [03:56:55:INFO] [0217/155655.116780:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 37 [03:56:55:INFO] 2019-02-17 15:56:55.142 ios_chrome_web_egtests[32270:415222] Attempting to type key h. [03:56:55:INFO] 2019-02-17 15:56:55.143 ios_chrome_web_egtests[32270:415222] Tapping on key: h. [03:56:55:INFO] 2019-02-17 15:56:55.209 ios_chrome_web_egtests[32270:415222] Attempting to type key e. [03:56:55:INFO] 2019-02-17 15:56:55.210 ios_chrome_web_egtests[32270:415222] Tapping on key: e. [03:56:55:INFO] 2019-02-17 15:56:55.272 ios_chrome_web_egtests[32270:415222] Attempting to type key t. [03:56:55:INFO] 2019-02-17 15:56:55.273 ios_chrome_web_egtests[32270:415222] Tapping on key: t. [03:56:55:INFO] [0217/155655.320695:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 41 [03:56:55:INFO] 2019-02-17 15:56:55.342 ios_chrome_web_egtests[32270:415222] Attempting to type key e. [03:56:55:INFO] 2019-02-17 15:56:55.343 ios_chrome_web_egtests[32270:415222] Tapping on key: e. [03:56:55:INFO] 2019-02-17 15:56:55.409 ios_chrome_web_egtests[32270:415222] Attempting to type key s. [03:56:55:INFO] 2019-02-17 15:56:55.410 ios_chrome_web_egtests[32270:415222] Tapping on key: s. [03:56:55:INFO] 2019-02-17 15:56:55.498 ios_chrome_web_egtests[32270:415222] Attempting to type key t. [03:56:55:INFO] 2019-02-17 15:56:55.499 ios_chrome_web_egtests[32270:415222] Tapping on key: t. [03:56:55:INFO] 2019-02-17 15:56:55.599 ios_chrome_web_egtests[32270:415222] Attempting to type key f. [03:56:55:INFO] 2019-02-17 15:56:55.601 ios_chrome_web_egtests[32270:415222] Tapping on key: f. [03:56:55:INFO] 2019-02-17 15:56:55.694 ios_chrome_web_egtests[32270:415222] Attempting to type key i. [03:56:55:INFO] 2019-02-17 15:56:55.695 ios_chrome_web_egtests[32270:415222] Tapping on key: i. [03:56:55:INFO] 2019-02-17 15:56:55.756 ios_chrome_web_egtests[32270:415222] Attempting to type key r. [03:56:55:INFO] 2019-02-17 15:56:55.757 ios_chrome_web_egtests[32270:415222] Tapping on key: r. [03:56:55:INFO] 2019-02-17 15:56:55.819 ios_chrome_web_egtests[32270:415222] Attempting to type key s. [03:56:55:INFO] 2019-02-17 15:56:55.820 ios_chrome_web_egtests[32270:415222] Tapping on key: s. [03:56:55:INFO] 2019-02-17 15:56:55.879 ios_chrome_web_egtests[32270:415222] Attempting to type key t. [03:56:55:INFO] 2019-02-17 15:56:55.880 ios_chrome_web_egtests[32270:415222] Tapping on key: t. [03:56:55:INFO] 2019-02-17 15:56:55.937 ios_chrome_web_egtests[32270:415222] Attempting to type key p. [03:56:55:INFO] 2019-02-17 15:56:55.938 ios_chrome_web_egtests[32270:415222] Tapping on key: p. [03:56:55:INFO] 2019-02-17 15:56:55.994 ios_chrome_web_egtests[32270:415222] Attempting to type key a. [03:56:55:INFO] 2019-02-17 15:56:55.995 ios_chrome_web_egtests[32270:415222] Tapping on key: a. [03:56:56:INFO] 2019-02-17 15:56:56.054 ios_chrome_web_egtests[32270:415222] Attempting to type key g. [03:56:56:INFO] 2019-02-17 15:56:56.054 ios_chrome_web_egtests[32270:415222] Tapping on key: g. [03:56:56:INFO] 2019-02-17 15:56:56.115 ios_chrome_web_egtests[32270:415222] Attempting to type key e. [03:56:56:INFO] 2019-02-17 15:56:56.115 ios_chrome_web_egtests[32270:415222] Tapping on key: e. [03:57:00:INFO] Test Case '-[CacheTestCase testCachingBehaviorOnSelectOmniboxSuggestion]' passed (9.919 seconds). [03:57:00:INFO] Test Suite 'CacheTestCase' passed at 2019-02-17 15:57:00.519. [03:57:00:INFO] Executed 3 tests, with 0 failures (0 unexpected) in 20.816 (20.821) seconds [03:57:00:INFO] Test Suite 'ChildWindowOpenByDOMTestCase' started at 2019-02-17 15:57:00.520 [03:57:00:INFO] [0217/155700.520968:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:57:00:INFO] Test Case '-[ChildWindowOpenByDOMTestCase test2ChildWindowsWithName]' started. [03:57:02:INFO] [0217/155702.592563:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:57:06:INFO] Test Case '-[ChildWindowOpenByDOMTestCase test2ChildWindowsWithName]' passed (6.353 seconds). [03:57:06:INFO] Test Case '-[ChildWindowOpenByDOMTestCase test2ChildWindowsWithoutName]' started. [03:57:14:INFO] Test Case '-[ChildWindowOpenByDOMTestCase test2ChildWindowsWithoutName]' passed (7.653 seconds). [03:57:14:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testChildWindowsWithAndWithoutName]' started. [03:57:22:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testChildWindowsWithAndWithoutName]' passed (7.633 seconds). [03:57:22:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testWindowClosedWithName]' started. [03:57:29:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testWindowClosedWithName]' passed (6.899 seconds). [03:57:29:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testWindowClosedWithoutName]' started. [03:57:37:INFO] Test Case '-[ChildWindowOpenByDOMTestCase testWindowClosedWithoutName]' passed (8.751 seconds). [03:57:37:INFO] Test Suite 'ChildWindowOpenByDOMTestCase' passed at 2019-02-17 15:57:37.814. [03:57:37:INFO] Executed 5 tests, with 0 failures (0 unexpected) in 37.288 (37.294) seconds [03:57:37:INFO] Test Suite 'ErrorPageTestCase' started at 2019-02-17 15:57:37.815 [03:57:37:INFO] [0217/155737.816377:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:57:37:INFO] Test Case '-[ErrorPageTestCase testReloadErrorPage]' started. [03:57:40:INFO] [0217/155740.039414:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:57:44:INFO] Test Case '-[ErrorPageTestCase testReloadErrorPage]' passed (6.287 seconds). [03:57:44:INFO] Test Case '-[ErrorPageTestCase testReloadPageAfterServerIsDown]' started. [03:57:46:INFO] [0217/155746.165148:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:57:50:INFO] Test Case '-[ErrorPageTestCase testReloadPageAfterServerIsDown]' passed (6.130 seconds). [03:57:50:INFO] Test Suite 'ErrorPageTestCase' passed at 2019-02-17 15:57:50.238. [03:57:50:INFO] Executed 2 tests, with 0 failures (0 unexpected) in 12.417 (12.423) seconds [03:57:50:INFO] Test Suite 'FormsTestCase' started at 2019-02-17 15:57:50.239 [03:57:50:INFO] [0217/155750.240118:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:57:50:INFO] Test Case '-[FormsTestCase testGoBackButtonAfterFormSubmission]' started. [03:57:52:INFO] [0217/155752.306561:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:57:57:INFO] Test Case '-[FormsTestCase testGoBackButtonAfterFormSubmission]' passed (7.122 seconds). [03:57:57:INFO] Test Case '-[FormsTestCase testPostFormEntryWithKeyboard]' started. [03:58:06:INFO] Test Case '-[FormsTestCase testPostFormEntryWithKeyboard]' passed (9.532 seconds). [03:58:06:INFO] Test Case '-[FormsTestCase testPostFormToSamePage]' started. [03:58:11:INFO] [0217/155811.060994:WARNING:web_state_impl.mm(655)] Script execution has failed: A JavaScript exception occurred [03:58:16:INFO] Test Case '-[FormsTestCase testPostFormToSamePage]' passed (9.223 seconds). [03:58:16:INFO] Test Case '-[FormsTestCase testRepostFormAfterIndexNavigation]' started. [03:58:28:INFO] Test Case '-[FormsTestCase testRepostFormAfterIndexNavigation]' passed (12.783 seconds). [03:58:28:INFO] Test Case '-[FormsTestCase testRepostFormAfterReload]' started. [03:58:38:INFO] Test Case '-[FormsTestCase testRepostFormAfterReload]' passed (9.157 seconds). [03:58:38:INFO] Test Case '-[FormsTestCase testRepostFormAfterTappingBack]' started. [03:58:41:INFO] [0217/155841.164732:WARNING:web_state_impl.mm(655)] Script execution has failed: A JavaScript exception occurred [03:58:48:INFO] Test Case '-[FormsTestCase testRepostFormAfterTappingBack]' passed (10.210 seconds). [03:58:48:INFO] Test Case '-[FormsTestCase testRepostFormAfterTappingBackAndForward]' started. [03:58:58:INFO] Test Case '-[FormsTestCase testRepostFormAfterTappingBackAndForward]' passed (10.220 seconds). [03:58:58:INFO] Test Case '-[FormsTestCase testRepostFormCancelling]' started. [03:59:07:INFO] Test Case '-[FormsTestCase testRepostFormCancelling]' passed (9.128 seconds). [03:59:07:INFO] Test Case '-[FormsTestCase testRepostFormCancellingAfterRedirect]' started. [03:59:10:INFO] [0217/155910.745784:WARNING:web_state_impl.mm(655)] Script execution has failed: A JavaScript exception occurred [03:59:14:INFO] Test Case '-[FormsTestCase testRepostFormCancellingAfterRedirect]' passed (7.155 seconds). [03:59:14:INFO] Test Case '-[FormsTestCase testRepostFormDismissedByNewNavigation]' started. [03:59:22:INFO] Test Case '-[FormsTestCase testRepostFormDismissedByNewNavigation]' passed (8.028 seconds). [03:59:22:INFO] Test Suite 'FormsTestCase' passed at 2019-02-17 15:59:22.806. [03:59:22:INFO] Executed 10 tests, with 0 failures (0 unexpected) in 92.559 (92.567) seconds [03:59:22:INFO] Test Suite 'HTTPAuthTestCase' started at 2019-02-17 15:59:22.807 [03:59:22:INFO] [0217/155922.807977:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:59:22:INFO] Test Case '-[HTTPAuthTestCase testCancellingBasicAuth]' started. [03:59:28:INFO] Test Case '-[HTTPAuthTestCase testCancellingBasicAuth]' passed (5.744 seconds). [03:59:28:INFO] Test Case '-[HTTPAuthTestCase testSuccessfullBasicAuth]' started. [03:59:31:INFO] 2019-02-17 15:59:31.393 ios_chrome_web_egtests[32270:415222] Attempting to type key g. [03:59:31:INFO] 2019-02-17 15:59:31.394 ios_chrome_web_egtests[32270:415222] Tapping on key: g. [03:59:31:INFO] 2019-02-17 15:59:31.445 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:59:31:INFO] 2019-02-17 15:59:31.445 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:59:31:INFO] 2019-02-17 15:59:31.496 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:59:31:INFO] 2019-02-17 15:59:31.497 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:59:31:INFO] 2019-02-17 15:59:31.548 ios_chrome_web_egtests[32270:415222] Attempting to type key d. [03:59:31:INFO] 2019-02-17 15:59:31.548 ios_chrome_web_egtests[32270:415222] Tapping on key: d. [03:59:31:INFO] 2019-02-17 15:59:31.599 ios_chrome_web_egtests[32270:415222] Attempting to type key u. [03:59:31:INFO] 2019-02-17 15:59:31.600 ios_chrome_web_egtests[32270:415222] Tapping on key: u. [03:59:31:INFO] 2019-02-17 15:59:31.651 ios_chrome_web_egtests[32270:415222] Attempting to type key s. [03:59:31:INFO] 2019-02-17 15:59:31.651 ios_chrome_web_egtests[32270:415222] Tapping on key: s. [03:59:31:INFO] 2019-02-17 15:59:31.702 ios_chrome_web_egtests[32270:415222] Attempting to type key e. [03:59:31:INFO] 2019-02-17 15:59:31.703 ios_chrome_web_egtests[32270:415222] Tapping on key: e. [03:59:31:INFO] 2019-02-17 15:59:31.755 ios_chrome_web_egtests[32270:415222] Attempting to type key r. [03:59:31:INFO] 2019-02-17 15:59:31.756 ios_chrome_web_egtests[32270:415222] Tapping on key: r. [03:59:32:INFO] 2019-02-17 15:59:32.592 ios_chrome_web_egtests[32270:415222] Attempting to type key g. [03:59:32:INFO] 2019-02-17 15:59:32.593 ios_chrome_web_egtests[32270:415222] Tapping on key: g. [03:59:32:INFO] 2019-02-17 15:59:32.644 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:59:32:INFO] 2019-02-17 15:59:32.644 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:59:32:INFO] 2019-02-17 15:59:32.695 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:59:32:INFO] 2019-02-17 15:59:32.696 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:59:32:INFO] 2019-02-17 15:59:32.751 ios_chrome_web_egtests[32270:415222] Attempting to type key d. [03:59:32:INFO] 2019-02-17 15:59:32.752 ios_chrome_web_egtests[32270:415222] Tapping on key: d. [03:59:32:INFO] 2019-02-17 15:59:32.804 ios_chrome_web_egtests[32270:415222] Attempting to type key p. [03:59:32:INFO] 2019-02-17 15:59:32.805 ios_chrome_web_egtests[32270:415222] Tapping on key: p. [03:59:32:INFO] 2019-02-17 15:59:32.856 ios_chrome_web_egtests[32270:415222] Attempting to type key a. [03:59:32:INFO] 2019-02-17 15:59:32.856 ios_chrome_web_egtests[32270:415222] Tapping on key: a. [03:59:32:INFO] 2019-02-17 15:59:32.908 ios_chrome_web_egtests[32270:415222] Attempting to type key s. [03:59:32:INFO] 2019-02-17 15:59:32.908 ios_chrome_web_egtests[32270:415222] Tapping on key: s. [03:59:32:INFO] 2019-02-17 15:59:32.960 ios_chrome_web_egtests[32270:415222] Attempting to type key s. [03:59:32:INFO] 2019-02-17 15:59:32.960 ios_chrome_web_egtests[32270:415222] Tapping on key: s. [03:59:34:INFO] [0217/155934.408441:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:59:37:INFO] Test Case '-[HTTPAuthTestCase testSuccessfullBasicAuth]' passed (8.790 seconds). [03:59:37:INFO] Test Case '-[HTTPAuthTestCase testUnsuccessfullBasicAuth]' started. [03:59:40:INFO] 2019-02-17 15:59:40.194 ios_chrome_web_egtests[32270:415222] Attempting to type key g. [03:59:40:INFO] 2019-02-17 15:59:40.195 ios_chrome_web_egtests[32270:415222] Tapping on key: g. [03:59:40:INFO] 2019-02-17 15:59:40.246 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:59:40:INFO] 2019-02-17 15:59:40.246 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:59:40:INFO] 2019-02-17 15:59:40.298 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:59:40:INFO] 2019-02-17 15:59:40.298 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:59:40:INFO] 2019-02-17 15:59:40.349 ios_chrome_web_egtests[32270:415222] Attempting to type key d. [03:59:40:INFO] 2019-02-17 15:59:40.349 ios_chrome_web_egtests[32270:415222] Tapping on key: d. [03:59:40:INFO] 2019-02-17 15:59:40.400 ios_chrome_web_egtests[32270:415222] Attempting to type key u. [03:59:40:INFO] 2019-02-17 15:59:40.401 ios_chrome_web_egtests[32270:415222] Tapping on key: u. [03:59:40:INFO] 2019-02-17 15:59:40.452 ios_chrome_web_egtests[32270:415222] Attempting to type key s. [03:59:40:INFO] 2019-02-17 15:59:40.453 ios_chrome_web_egtests[32270:415222] Tapping on key: s. [03:59:40:INFO] 2019-02-17 15:59:40.504 ios_chrome_web_egtests[32270:415222] Attempting to type key e. [03:59:40:INFO] 2019-02-17 15:59:40.504 ios_chrome_web_egtests[32270:415222] Tapping on key: e. [03:59:40:INFO] 2019-02-17 15:59:40.556 ios_chrome_web_egtests[32270:415222] Attempting to type key r. [03:59:40:INFO] 2019-02-17 15:59:40.556 ios_chrome_web_egtests[32270:415222] Tapping on key: r. [03:59:41:INFO] 2019-02-17 15:59:41.442 ios_chrome_web_egtests[32270:415222] Attempting to type key g. [03:59:41:INFO] 2019-02-17 15:59:41.443 ios_chrome_web_egtests[32270:415222] Tapping on key: g. [03:59:41:INFO] 2019-02-17 15:59:41.494 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:59:41:INFO] 2019-02-17 15:59:41.494 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:59:41:INFO] 2019-02-17 15:59:41.545 ios_chrome_web_egtests[32270:415222] Attempting to type key o. [03:59:41:INFO] 2019-02-17 15:59:41.546 ios_chrome_web_egtests[32270:415222] Tapping on key: o. [03:59:41:INFO] 2019-02-17 15:59:41.596 ios_chrome_web_egtests[32270:415222] Attempting to type key d. [03:59:41:INFO] 2019-02-17 15:59:41.597 ios_chrome_web_egtests[32270:415222] Tapping on key: d. [03:59:41:INFO] 2019-02-17 15:59:41.648 ios_chrome_web_egtests[32270:415222] Attempting to type key p. [03:59:41:INFO] 2019-02-17 15:59:41.648 ios_chrome_web_egtests[32270:415222] Tapping on key: p. [03:59:41:INFO] 2019-02-17 15:59:41.699 ios_chrome_web_egtests[32270:415222] Attempting to type key a. [03:59:41:INFO] 2019-02-17 15:59:41.700 ios_chrome_web_egtests[32270:415222] Tapping on key: a. [03:59:41:INFO] 2019-02-17 15:59:41.751 ios_chrome_web_egtests[32270:415222] Attempting to type key s. [03:59:41:INFO] 2019-02-17 15:59:41.752 ios_chrome_web_egtests[32270:415222] Tapping on key: s. [03:59:41:INFO] 2019-02-17 15:59:41.803 ios_chrome_web_egtests[32270:415222] Attempting to type key s. [03:59:41:INFO] 2019-02-17 15:59:41.803 ios_chrome_web_egtests[32270:415222] Tapping on key: s. [03:59:47:INFO] Test Case '-[HTTPAuthTestCase testUnsuccessfullBasicAuth]' passed (9.741 seconds). [03:59:47:INFO] Test Suite 'HTTPAuthTestCase' passed at 2019-02-17 15:59:47.087. [03:59:47:INFO] Executed 3 tests, with 0 failures (0 unexpected) in 24.274 (24.280) seconds [03:59:47:INFO] Test Suite 'JSPrintTestCase' started at 2019-02-17 15:59:47.087 [03:59:47:INFO] [0217/155947.088876:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:59:47:INFO] Test Case '-[JSPrintTestCase testWebPrintButton]' started. [03:59:49:INFO] [0217/155949.152368:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [03:59:50:INFO] 2019-02-17 15:59:50.711 ios_chrome_web_egtests[32270:415222] Unbalanced calls to begin/end appearance transitions for <UIViewController: 0x7ff130193560>. [03:59:53:INFO] 2019-02-17 15:59:53.172 ios_chrome_web_egtests[32270:415222] Warning: Attempt to dismiss from view controller <UIViewController: 0x7ff130193560> while a presentation or dismiss is in progress! [03:59:55:INFO] Test Case '-[JSPrintTestCase testWebPrintButton]' passed (8.445 seconds). [03:59:55:INFO] Test Suite 'JSPrintTestCase' passed at 2019-02-17 15:59:55.540. [03:59:55:INFO] Executed 1 test, with 0 failures (0 unexpected) in 8.445 (8.452) seconds [03:59:55:INFO] Test Suite 'NavigationTestCase' started at 2019-02-17 15:59:55.540 [03:59:55:INFO] [0217/155955.541392:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [03:59:55:INFO] Test Case '-[NavigationTestCase test301Redirect]' started. [03:59:57:INFO] [0217/155957.601617:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:00:06:INFO] Test Case '-[NavigationTestCase test301Redirect]' passed (10.909 seconds). [04:00:06:INFO] Test Case '-[NavigationTestCase testHistoryBackAndForwardAroundNTP]' started. [04:00:08:INFO] [0217/160008.504510:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:00:14:INFO] Test Case '-[NavigationTestCase testHistoryBackAndForwardAroundNTP]' passed (8.469 seconds). [04:00:14:INFO] Test Case '-[NavigationTestCase testHistoryBackNavigation]' started. [04:00:16:INFO] [0217/160016.974159:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:00:23:INFO] Test Case '-[NavigationTestCase testHistoryBackNavigation]' passed (8.380 seconds). [04:00:23:INFO] Test Case '-[NavigationTestCase testHistoryCrossDocumentLoad]' started. [04:00:25:INFO] [0217/160025.356449:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:00:31:INFO] Test Case '-[NavigationTestCase testHistoryCrossDocumentLoad]' passed (8.198 seconds). [04:00:31:INFO] Test Case '-[NavigationTestCase testHistoryForwardNavigation]' started. [04:00:33:INFO] [0217/160033.562655:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:00:39:INFO] Test Case '-[NavigationTestCase testHistoryForwardNavigation]' passed (8.399 seconds). [04:00:39:INFO] Test Case '-[NavigationTestCase testHistoryGoDelta]' started. [04:00:41:INFO] [0217/160041.965117:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:00:50:INFO] Test Case '-[NavigationTestCase testHistoryGoDelta]' passed (10.341 seconds). [04:00:50:INFO] Test Case '-[NavigationTestCase testHistoryGoDeltaZero]' started. [04:00:52:INFO] [0217/160052.292770:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:00:56:INFO] Test Case '-[NavigationTestCase testHistoryGoDeltaZero]' passed (6.063 seconds). [04:00:56:INFO] Test Case '-[NavigationTestCase testHistoryGoNoParameter]' started. [04:00:58:INFO] [0217/160058.372706:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:01:02:INFO] Test Case '-[NavigationTestCase testHistoryGoNoParameter]' passed (6.064 seconds). [04:01:02:INFO] Test Case '-[NavigationTestCase testHistoryGoOutOfBounds]' started. [04:01:04:INFO] [0217/160104.415381:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:01:09:INFO] Test Case '-[NavigationTestCase testHistoryGoOutOfBounds]' passed (7.008 seconds). [04:01:09:INFO] Test Case '-[NavigationTestCase testJavaScriptRedirect]' started. [04:01:11:INFO] [0217/160111.437232:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:01:17:INFO] Test Case '-[NavigationTestCase testJavaScriptRedirect]' passed (8.603 seconds). [04:01:17:INFO] Test Case '-[NavigationTestCase testRedirectRefresh]' started. [04:01:20:INFO] [0217/160120.018392:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:01:28:INFO] Test Case '-[NavigationTestCase testRedirectRefresh]' passed (10.915 seconds). [04:01:28:INFO] Test Case '-[NavigationTestCase testRedirectWindow]' started. [04:01:30:INFO] [0217/160130.953886:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:01:39:INFO] Test Case '-[NavigationTestCase testRedirectWindow]' passed (10.942 seconds). [04:01:39:INFO] Test Case '-[NavigationTestCase testRestoreHistoryToNTPAndNavigateForward]' started. [04:01:41:INFO] [0217/160141.889915:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:01:47:INFO] Test Case '-[NavigationTestCase testRestoreHistoryToNTPAndNavigateForward]' passed (8.060 seconds). [04:01:47:INFO] Test Case '-[NavigationTestCase testRestoreHistoryToWebUIAndNavigateForward]' started. [04:01:51:INFO] [0217/160151.055043:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:01:53:INFO] [0217/160153.148722:ERROR:crw_web_controller.mm(2416)] WKWebView snapshot error: 1 [04:01:58:INFO] Test Case '-[NavigationTestCase testRestoreHistoryToWebUIAndNavigateForward]' passed (10.445 seconds). [04:01:58:INFO] Test Case '-[NavigationTestCase testWindowLocationChangeHash]' started. [04:02:00:INFO] [0217/160200.394263:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:02:07:INFO] Test Case '-[NavigationTestCase testWindowLocationChangeHash]' passed (9.541 seconds). [04:02:07:INFO] Test Case '-[NavigationTestCase testWindowLocationChangeToSameHash]' started. [04:02:09:INFO] [0217/160209.931751:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:02:16:INFO] Test Case '-[NavigationTestCase testWindowLocationChangeToSameHash]' passed (8.500 seconds). [04:02:16:INFO] Test Case '-[NavigationTestCase testWindowLocationReplaceAndChangeHash]' started. [04:02:18:INFO] [0217/160218.441223:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:02:24:INFO] Test Case '-[NavigationTestCase testWindowLocationReplaceAndChangeHash]' passed (8.275 seconds). [04:02:24:INFO] Test Suite 'NavigationTestCase' passed at 2019-02-17 16:02:24.666. [04:02:24:INFO] Executed 17 tests, with 0 failures (0 unexpected) in 149.110 (149.125) seconds [04:02:24:INFO] Test Suite 'ProgressIndicatorTestCase' started at 2019-02-17 16:02:24.666 [04:02:24:INFO] [0217/160224.667510:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [04:02:24:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorDisappearsAfterFormSubmit]' started. [04:02:26:INFO] [0217/160226.725181:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:02:30:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorDisappearsAfterFormSubmit]' passed (6.046 seconds). [04:02:30:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorDisappearsAfterSuppressedFormPost]' started. [04:02:36:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorDisappearsAfterSuppressedFormPost]' passed (5.989 seconds). [04:02:36:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorShown]' started. [04:02:43:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorShown]' passed (6.302 seconds). [04:02:43:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorShownOnFormSubmit]' started. [04:02:46:INFO] [0217/160246.119110:WARNING:web_state_impl.mm(655)] Script execution has failed: A JavaScript exception occurred [04:02:50:INFO] Test Case '-[ProgressIndicatorTestCase testProgressIndicatorShownOnFormSubmit]' passed (7.378 seconds). [04:02:50:INFO] Test Suite 'ProgressIndicatorTestCase' passed at 2019-02-17 16:02:50.388. [04:02:50:INFO] Executed 4 tests, with 0 failures (0 unexpected) in 25.715 (25.722) seconds [04:02:50:INFO] Test Suite 'PushAndReplaceStateNavigationTestCase' started at 2019-02-17 16:02:50.389 [04:02:50:INFO] [0217/160250.389881:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [04:02:50:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryNavigatingPastNonPushedURL]' started. [04:02:52:INFO] [0217/160252.477412:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:03:04:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryNavigatingPastNonPushedURL]' passed (14.569 seconds). [04:03:04:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryPushStateThenGoBackAndForward]' started. [04:03:14:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryPushStateThenGoBackAndForward]' passed (9.801 seconds). [04:03:14:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryPushUnicodeCharacters]' started. [04:03:22:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryPushUnicodeCharacters]' passed (7.716 seconds). [04:03:22:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryReplaceStateThenGoBackAndForward]' started. [04:03:34:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryReplaceStateThenGoBackAndForward]' passed (12.485 seconds). [04:03:34:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryWithBase]' started. [04:03:40:INFO] Test Case '-[PushAndReplaceStateNavigationTestCase testHtml5HistoryWithBase]' passed (5.095 seconds). [04:03:40:INFO] Test Suite 'PushAndReplaceStateNavigationTestCase' passed at 2019-02-17 16:03:40.060. [04:03:40:INFO] Executed 5 tests, with 0 failures (0 unexpected) in 49.666 (49.672) seconds [04:03:40:INFO] Test Suite 'StopLoadingTestCase' started at 2019-02-17 16:03:40.061 [04:03:40:INFO] [0217/160340.062054:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [04:03:40:INFO] Test Case '-[StopLoadingTestCase testStopLoading]' started. [04:03:51:INFO] Test Case '-[StopLoadingTestCase testStopLoading]' passed (11.024 seconds). [04:03:51:INFO] Test Suite 'StopLoadingTestCase' passed at 2019-02-17 16:03:51.089. [04:03:51:INFO] Executed 1 test, with 0 failures (0 unexpected) in 11.024 (11.028) seconds [04:03:51:INFO] Test Suite 'TabOrderTestCase' started at 2019-02-17 16:03:51.089 [04:03:51:INFO] [0217/160351.090485:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [04:03:51:INFO] Test Case '-[TabOrderTestCase testChildTabOrdering]' started. [04:03:53:INFO] [0217/160353.167142:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:04:14:INFO] Test Case '-[TabOrderTestCase testChildTabOrdering]' passed (23.016 seconds). [04:04:14:INFO] Test Suite 'TabOrderTestCase' passed at 2019-02-17 16:04:14.112. [04:04:14:INFO] Executed 1 test, with 0 failures (0 unexpected) in 23.016 (23.023) seconds [04:04:14:INFO] Test Suite 'VisibleURLTestCase' started at 2019-02-17 16:04:14.113 [04:04:14:INFO] [0217/160414.113784:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [04:04:14:INFO] Test Case '-[VisibleURLTestCase testBackForwardNavigation]' started. [04:04:16:INFO] [0217/160416.236294:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:04:26:INFO] Test Case '-[VisibleURLTestCase testBackForwardNavigation]' passed (12.293 seconds). [04:04:26:INFO] Test Case '-[VisibleURLTestCase testBackNavigationWithPendingReload]' started. [04:04:30:INFO] [0217/160430.488688:ERROR:crw_web_controller.mm(2416)] WKWebView snapshot error: 1 [04:04:39:INFO] Test Case '-[VisibleURLTestCase testBackNavigationWithPendingReload]' passed (13.333 seconds). [04:04:39:INFO] Test Case '-[VisibleURLTestCase testBackNavigationWithPendingRendererInitiatedNavigation]' started. [04:04:43:INFO] [0217/160443.834559:ERROR:crw_web_controller.mm(2416)] WKWebView snapshot error: 1 [04:04:48:INFO] Test Case '-[VisibleURLTestCase testBackNavigationWithPendingRendererInitiatedNavigation]' passed (9.144 seconds). [04:04:48:INFO] Test Case '-[VisibleURLTestCase testDoubleBackJSNavigation]' started. [04:04:54:INFO] [0217/160454.046764:ERROR:crw_web_controller.mm(2416)] WKWebView snapshot error: 1 [04:04:58:INFO] Test Case '-[VisibleURLTestCase testDoubleBackJSNavigation]' passed (10.004 seconds). [04:04:58:INFO] Test Case '-[VisibleURLTestCase testDoubleBackNavigation]' started. [04:05:04:INFO] [0217/160504.067191:ERROR:crw_web_controller.mm(2416)] WKWebView snapshot error: 1 [04:05:09:INFO] Test Case '-[VisibleURLTestCase testDoubleBackNavigation]' passed (10.466 seconds). [04:05:09:INFO] Test Case '-[VisibleURLTestCase testDoubleForwardNavigationToWebUIPage]' started. [04:05:21:INFO] Test Case '-[VisibleURLTestCase testDoubleForwardNavigationToWebUIPage]' passed (11.735 seconds). [04:05:21:INFO] Test Case '-[VisibleURLTestCase testHistoryNavigation]' started. [04:05:25:INFO] [0217/160525.194537:ERROR:crw_web_controller.mm(2416)] WKWebView snapshot error: 1 [04:05:32:INFO] Test Case '-[VisibleURLTestCase testHistoryNavigation]' passed (11.380 seconds). [04:05:32:INFO] Test Case '-[VisibleURLTestCase testJSBackForwardNavigation]' started. [04:05:36:INFO] [0217/160536.568109:ERROR:crw_web_controller.mm(2416)] WKWebView snapshot error: 1 [04:05:43:INFO] Test Case '-[VisibleURLTestCase testJSBackForwardNavigation]' passed (11.514 seconds). [04:05:43:INFO] Test Case '-[VisibleURLTestCase testJSGoNavigation]' started. [04:05:48:INFO] [0217/160548.093369:ERROR:crw_web_controller.mm(2416)] WKWebView snapshot error: 1 [04:05:55:INFO] Test Case '-[VisibleURLTestCase testJSGoNavigation]' passed (11.794 seconds). [04:05:55:INFO] Test Case '-[VisibleURLTestCase testRendererInitiatedNavigationWithPendingBackNavigation]' started. [04:05:59:INFO] [0217/160559.896682:ERROR:crw_web_controller.mm(2416)] WKWebView snapshot error: 1 [04:06:04:INFO] Test Case '-[VisibleURLTestCase testRendererInitiatedNavigationWithPendingBackNavigation]' passed (9.193 seconds). [04:06:04:INFO] Test Case '-[VisibleURLTestCase testStoppingPendingBackNavigationAndReload]' started. [04:06:20:INFO] Test Case '-[VisibleURLTestCase testStoppingPendingBackNavigationAndReload]' passed (15.906 seconds). [04:06:20:INFO] Test Suite 'VisibleURLTestCase' passed at 2019-02-17 16:06:20.888. [04:06:20:INFO] Executed 11 tests, with 0 failures (0 unexpected) in 126.762 (126.775) seconds [04:06:20:INFO] Test Suite 'WindowOpenByDOMTestCase' started at 2019-02-17 16:06:20.888 [04:06:20:INFO] [0217/160620.889686:WARNING:loopback_server.cc(723)] Loopback sync persistent state file does not exist. [04:06:20:INFO] Test Case '-[WindowOpenByDOMTestCase testBlockPopupInjectedIntoOpenedWindow]' started. [04:06:23:INFO] [0217/160623.029133:WARNING:embedded_test_server.cc(237)] Request not handled. Returning 404: /favicon.ico [04:06:27:INFO] Test Case '-[WindowOpenByDOMTestCase testBlockPopupInjectedIntoOpenedWindow]' passed (6.312 seconds). [04:06:27:INFO] Test Case '-[WindowOpenByDOMTestCase testCloseWindowNotOpenByDOM]' started. [04:06:32:INFO] Test Case '-[WindowOpenByDOMTestCase testCloseWindowNotOpenByDOM]' passed (4.996 seconds). [04:06:32:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTarget]' started. [04:06:39:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTarget]' passed (6.851 seconds). [04:06:39:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetMultipleTimes]' started. [04:06:49:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetMultipleTimes]' passed (10.360 seconds). [04:06:49:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetSessionStorage]' started. [04:06:56:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetSessionStorage]' passed (6.832 seconds). [04:06:56:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithDelayedClose]' started. [04:07:04:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithDelayedClose]' passed (8.301 seconds). [04:07:04:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithImmediateClose]' started. [04:07:10:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithImmediateClose]' passed (6.111 seconds). [04:07:10:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithoutUserGesture]' started. [04:07:16:INFO] Test Case '-[WindowOpenByDOMTestCase testLinkWithBlankTargetWithoutUserGesture]' passed (5.432 seconds). [04:07:16:INFO] Test Case '-[WindowOpenByDOMTestCase testLocationReplaceInWindowOpenWithEmptyTarget]' started. [04:07:22:INFO] Test Case '-[WindowOpenByDOMTestCase testLocationReplaceInWindowOpenWithEmptyTarget]' passed (6.111 seconds). [04:07:22:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndAssignToHref]' started. [04:07:28:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndAssignToHref]' passed (6.162 seconds). [04:07:28:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndCallLocationAssign]' started. [04:07:34:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndCallLocationAssign]' passed (6.202 seconds). [04:07:34:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndSetLocation]' started. [04:07:40:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenAndSetLocation]' passed (6.170 seconds). [04:07:40:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithBlankTarget]' started. [04:07:46:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithBlankTarget]' passed (6.119 seconds). [04:07:46:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithButtonOnClick]' started. [04:07:52:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithButtonOnClick]' passed (6.107 seconds). [04:07:52:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithEmptyTarget]' started. [04:07:59:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithEmptyTarget]' passed (6.105 seconds). [04:07:59:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithMetaRefresh]' started. [04:08:05:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithMetaRefresh]' passed (6.162 seconds). [04:08:05:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithPreventDefaultLink]' started. [04:08:11:INFO] Test Case '-[WindowOpenByDOMTestCase testWindowOpenWithPreventDefaultLink]' passed (6.635 seconds). [04:08:11:INFO] Test Suite 'WindowOpenByDOMTestCase' passed at 2019-02-17 16:08:11.873. [04:08:11:INFO] Executed 17 tests, with 0 failures (0 unexpected) in 110.968 (110.985) seconds [04:08:11:INFO] Test Suite 'ios_chrome_web_egtests.app' passed at 2019-02-17 16:08:11.874. [04:08:11:INFO] Executed 94 tests, with 0 failures (0 unexpected) in 785.849 (787.887) seconds [04:08:11:INFO] Test Suite 'All tests' passed at 2019-02-17 16:08:11.875. [04:08:11:INFO] Executed 94 tests, with 0 failures (0 unexpected) in 785.849 (787.889) seconds [04:08:12:INFO] [04:08:12:INFO] [04:08:12:INFO] Test session results and logs: [04:08:12:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-exkhipnciwcjdlhatgxotkxhxsbj/Logs/Test/Test-Transient Testing-2019.02.17_15-54-27--0800.xcresult [04:08:12:INFO] [04:08:12:INFO] 2019-02-17 16:08:12.334 xcodebuild[32147:413511] [MT] IDETestOperationsObserverDebug: 824.970 elapsed -- Testing started completed. [04:08:12:INFO] 2019-02-17 16:08:12.334 xcodebuild[32147:413511] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start [04:08:12:INFO] 2019-02-17 16:08:12.334 xcodebuild[32147:413511] [MT] IDETestOperationsObserverDebug: 824.970 sec, +824.970 sec -- end [04:08:12:INFO] ** TEST EXECUTE SUCCEEDED ** [04:08:12:INFO] [04:08:16:INFO] Break line finished! [04:08:16:DEBUG] Finished print_process_output. [04:08:16:INFO] Waiting for test process to terminate. [04:08:16:INFO] Test process terminated. [04:08:16:DEBUG] Stdout flushed after test process. [04:08:16:DEBUG] Processing test results. [04:08:16:INFO] /b/s/w/ir/src/out/Debug-iphonesimulator/iossim returned 0 [04:08:16:DEBUG] Extracting test data. [04:08:17:DEBUG] Retrieving crash reports. [04:08:17:DEBUG] Retrieving derived data. [04:08:17:DEBUG] Making desktop screenshots. [04:08:17:DEBUG] Killing simulators. [04:08:22:DEBUG] Wiping simulator. Device wiped. [04:08:24:DEBUG] End of tear_down. 2019-02-17 16:23:15,661 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6/4316b30c7467f410'] 2019-02-17 16:23:15,661 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6/4316b30c7467f410/output.json']) Found: [] Expected: ['/b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6/4316b30c7467f410/output.json'] 2019-02-17 16:23:15,661 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6' Found ['/b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6/4316b30c7467f410'] 2019-02-17 16:23:15,661 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6/4316b30c7467f410/output.json'] 2019-02-17 16:23:15,662 - root: [INFO] merge_cmd: /b/s/w/ir/cache/vpython/5b0713/bin/python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/swarming/resources/noop_merge.py --summary-json /b/s/w/ir/tmp/t/tmpl_Bsca.json --task-output-dir /b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6 -o /b/s/w/ir/tmp/t/tmpjZTMxV.json Running ['/b/s/w/ir/cache/vpython/5b0713/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpl_Bsca.json', '--task-output-dir', '/b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6', '-o', '/b/s/w/ir/tmp/t/tmpjZTMxV.json'] in None (env: None) Command ['/b/s/w/ir/cache/vpython/5b0713/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpl_Bsca.json', '--task-output-dir', '/b/s/w/ir/kitchen-workdir/recipe_cleanup/35VBWKV6', '-o', '/b/s/w/ir/tmp/t/tmpjZTMxV.json'] returned exit code 0