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

{ "shards": [ { "bot_dimensions": [ { "key": "cores", "value": [ "8" ] }, { "key": "cpu", "value": [ "x86", "x86-64", "x86-64-Broadwell_GCE", "x86-64-avx2" ] }, { "key": "gce", "value": [ "1" ] }, { "key": "gpu", "value": [ "none" ] }, { "key": "id", "value": [ "chrome-trusty-89-7j18" ] }, { "key": "image", "value": [ "chrome-trusty-18091700-38cc06ee3ee" ] }, { "key": "inside_docker", "value": [ "0" ] }, { "key": "kvm", "value": [ "1" ] }, { "key": "machine_type", "value": [ "n1-standard-8" ] }, { "key": "os", "value": [ "Linux", "Ubuntu", "Ubuntu-14.04" ] }, { "key": "pool", "value": [ "Chrome" ] }, { "key": "python", "value": [ "2.7.6" ] }, { "key": "server_version", "value": [ "4201-b04f7f8" ] }, { "key": "zone", "value": [ "us", "us-east", "us-east1", "us-east1-b" ] } ], "bot_id": "chrome-trusty-89-7j18", "bot_version": "51d929b905e4fffb3652f17e0ff8dceb0f7077275d215d276fb6c5a2f238b3f7", "cipd_pins": { "client_package": { "package_name": "infra/tools/cipd/linux-amd64", "version": "nFftZl2kFquaI2EUmPGwzbc5sIbCocl9L55UeASqlLsC" }, "packages": [ { "package_name": "infra/python/cpython/linux-amd64", "path": ".swarming_module", "version": "46c0c897ca0f053799ee41fd148bb7a47232df47" }, { "package_name": "infra/tools/luci/logdog/butler/linux-amd64", "path": ".swarming_module", "version": "2737ea8ed9b958f4d5aa9ffe106115a649ada241" }, { "package_name": "infra/tools/luci/vpython-native/linux-amd64", "path": ".swarming_module", "version": "OAXVAmcUSrvDygYUrCDzv20LRono9938YOHPu0zKowgC" }, { "package_name": "infra/tools/luci/vpython/linux-amd64", "path": ".swarming_module", "version": "ucaOciwAE9aweCUDOrmSvyiwrjmbywuB0NzAGUXIHjAC" } ] }, "completed_ts": "2019-03-17T08:00:57.453414", "costs_usd": [ 0.0244893930572267 ], "created_ts": "2019-03-17T07:57:25.496431", "duration": 168.98457407951355, "modified_ts": "2019-03-17T08:00:57.453414", "name": "extensions_browsertests/Ubuntu-14.04/7ad0ffe58b/Linux ChromiumOS MSan Tests/11842", "output": "0 files remaining...\nAdditional test environment:\n CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox\n CHROME_HEADLESS=1\n G_SLICE=always-malloc\n LANG=en_US.UTF-8\n LLVM_SYMBOLIZER_PATH=/b/s/w/ir/third_party/llvm-build/Release+Asserts/bin/llvm-symbolizer\n MSAN_OPTIONS=symbolize=0 handle_abort=1\n NSS_DISABLE_ARENA_FREE_LIST=1\n NSS_DISABLE_UNLOAD=1\nCommand: ./extensions_browsertests --test-launcher-bot-mode --cfi-diag=0 --test-launcher-print-test-stdio=always --test-launcher-summary-output=/b/s/w/iof5RZW3/output.json\n\nIMPORTANT DEBUGGING NOTE: each test is run inside its own process.\nFor debugging a test inside a debugger, use the\n--gtest_filter=<your_test_name> flag along with either\n--single_process (to run the test in one launcher/browser process) or\n--single-process (to do the above, and also run Chrome in single-process mode).\nUsing sharding settings from environment. This is shard 0/1\nUsing 4 parallel jobs.\n[ RUN ] AudioApiTest.OnLevelChangedOutputDevice\n\nDevTools listening on ws://127.0.0.1:45117/devtools/browser/9cd23960-35e4-410b-bc1c-610306258de1\n[13299:13299:0317/005846.299931:458149705:INFO:CONSOLE(0)] \"[SUCCESS] waitForLevelChangedEventTests\", source: chrome-extension://lfbhhclfciphcmdcidfjmfhbocjeccba/_generated_background_page.html (0)\n[13299:13343:0317/005846.354299:458204062:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] AudioApiTest.OnLevelChangedOutputDevice (2317 ms)\n[1/202] AudioApiTest.OnLevelChangedOutputDevice (2686 ms)\n[ RUN ] AudioApiTest.OnOutputMuteChanged\n\nDevTools listening on ws://127.0.0.1:42152/devtools/browser/aa628c42-d7be-4d38-9321-819c44c9799d\n[13300:13300:0317/005846.185105:458034886:INFO:CONSOLE(0)] \"[SUCCESS] waitForMuteChangedEventTests\", source: chrome-extension://cfgojhiaibbkibjdaoakjhgdhodgjlkl/_generated_background_page.html (0)\n[13300:13349:0317/005846.251001:458100763:ERROR:browser_process_sub_thread.cc(217)] Waited 10 ms for network service\n[ OK ] AudioApiTest.OnOutputMuteChanged (2194 ms)\n[2/202] AudioApiTest.OnOutputMuteChanged (2735 ms)\n[ RUN ] AudioApiTest.OnInputMuteChanged\n\nDevTools listening on ws://127.0.0.1:34966/devtools/browser/fa4db98e-91ca-409b-b8fb-ff6c3dc92cec\n[13301:13301:0317/005846.190326:458040109:INFO:CONSOLE(0)] \"[SUCCESS] waitForMuteChangedEventTests\", source: chrome-extension://dgipifpljmbbgpcffjdepehfbpoonbfa/_generated_background_page.html (0)\n[13301:13367:0317/005846.254760:458104526:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] AudioApiTest.OnInputMuteChanged (2149 ms)\n[3/202] AudioApiTest.OnInputMuteChanged (2743 ms)\n[ RUN ] AudioApiTest.Audio\n\nDevTools listening on ws://127.0.0.1:43937/devtools/browser/f7b658d3-f33a-4897-a232-87d37549f274\n[13298:13298:0317/005844.889383:456739152:ERROR:device_event_log_impl.cc(159)] [00:58:44.889] Network: device_event_log.cc:122 @@@ Slow method: ../../chromeos/network/network_state_handler.cc:ManagedStateListChanged: 115ms\n[13298:13298:0317/005846.087328:457937101:INFO:CONSOLE(0)] \"[SUCCESS] startDeviceChangedListener\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.158739:458008513:INFO:CONSOLE(0)] \"[SUCCESS] getDevicesTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.210617:458060389:INFO:CONSOLE(0)] \"[SUCCESS] getDevicesWithEmptyFilterTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.241340:458091108:INFO:CONSOLE(0)] \"[SUCCESS] getInputDevicesTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.264469:458114237:INFO:CONSOLE(0)] \"[SUCCESS] getOutputDevicesTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.345881:458195644:INFO:CONSOLE(0)] \"[SUCCESS] getActiveDevicesTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.389076:458238848:INFO:CONSOLE(0)] \"[SUCCESS] getInactiveDevicesTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.455532:458305305:INFO:CONSOLE(0)] \"[SUCCESS] setPropertiesTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.469595:458319366:INFO:CONSOLE(0)] \"[SUCCESS] inputMuteTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.485483:458335244:INFO:CONSOLE(0)] \"[SUCCESS] outputMuteTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.506861:458356631:INFO:CONSOLE(0)] \"[SUCCESS] setActiveDevicesTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.532020:458381792:INFO:CONSOLE(0)] \"[SUCCESS] setActiveDevicesOutputOnlyTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.567548:458417452:INFO:CONSOLE(0)] \"[SUCCESS] setActiveDevicesFailInputTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.599979:458449751:INFO:CONSOLE(0)] \"[SUCCESS] setActiveDevicesFailOutputTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.618977:458468751:INFO:CONSOLE(0)] \"[SUCCESS] clearActiveDevicesTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.624907:458474674:INFO:CONSOLE(0)] \"[SUCCESS] verifyNoDeviceChangedEvents\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.633473:458483246:INFO:CONSOLE(0)] \"[SUCCESS] deprecated_GetInfoTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.695705:458545467:INFO:CONSOLE(0)] \"[SUCCESS] deprecated_setProperties_isMuted\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.754154:458603916:INFO:CONSOLE(0)] \"[SUCCESS] deprecated_setProperties_volume\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.828191:458677952:INFO:CONSOLE(0)] \"[SUCCESS] deprecated_setProperties_gain\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13298:0317/005846.838936:458688697:INFO:CONSOLE(0)] \"[SUCCESS] deprecated_SetActiveDevicesTest\", source: chrome-extension://dghjakdgbamppfnglidiciilfimhefjk/_generated_background_page.html (0)\n[13298:13336:0317/005846.887870:458737631:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] AudioApiTest.Audio (2899 ms)\n[4/202] AudioApiTest.Audio (3208 ms)\n[ RUN ] BluetoothShellApiTest.ApiSanityCheck\n\nDevTools listening on ws://127.0.0.1:38228/devtools/browser/71b227bb-74e0-4455-886f-15dafcd74c2b\n[13585:13585:0317/005848.458922:460308684:INFO:CONSOLE(0)] \"[SUCCESS] bluetoothSanityCheck\", source: chrome-extension://pjdjhejcdkeebjehnokfbfnjmgmgdjlc/_generated_background_page.html (0)\n[ OK ] BluetoothShellApiTest.ApiSanityCheck (1386 ms)\n[5/202] BluetoothShellApiTest.ApiSanityCheck (1599 ms)\n[ RUN ] AudioApiTest.OnNodesChangedAddNodes\n\nDevTools listening on ws://127.0.0.1:42585/devtools/browser/f72d2dcc-9bd7-44cb-8e1f-86036e683af9\n[13565:13565:0317/005848.235020:460084791:INFO:CONSOLE(0)] \"[SUCCESS] waitForDeviceChangedEventTests\", source: chrome-extension://dbflnniincamlgejphenlbepnpefoohf/_generated_background_page.html (0)\n[ OK ] AudioApiTest.OnNodesChangedAddNodes (1719 ms)\n[6/202] AudioApiTest.OnNodesChangedAddNodes (2150 ms)\n[ RUN ] AudioApiTest.OnNodesChangedRemoveNodes\n\nDevTools listening on ws://127.0.0.1:37156/devtools/browser/e5db2316-fb90-4fd7-b584-2b4edad27b1d\n[13566:13566:0317/005848.292771:460142548:INFO:CONSOLE(0)] \"[SUCCESS] waitForDeviceChangedEventTests\", source: chrome-extension://fechlgojfnpcmbbigekkpakejfmhnajc/_generated_background_page.html (0)\n[13566:13618:0317/005848.342376:460192136:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] AudioApiTest.OnNodesChangedRemoveNodes (1714 ms)\n[7/202] AudioApiTest.OnNodesChangedRemoveNodes (2132 ms)\n[ RUN ] WhitelistedAudioApiTest.DeprecatedApi\n\nDevTools listening on ws://127.0.0.1:33470/devtools/browser/25ce1702-280a-4577-a843-cbc64291ae0a\n[13567:13567:0317/005848.299569:460149357:INFO:CONSOLE(0)] \"[SUCCESS] startDeviceChangedListener\", source: chrome-extension://jlgnoeceollaejlkenecblnjmdcfhfgc/_generated_background_page.html (0)\n[13567:13567:0317/005848.380716:460230486:INFO:CONSOLE(0)] \"[SUCCESS] getInfoTest\", source: chrome-extension://jlgnoeceollaejlkenecblnjmdcfhfgc/_generated_background_page.html (0)\n[13567:13567:0317/005848.419937:460269708:INFO:CONSOLE(0)] \"[SUCCESS] setActiveDevicesTest\", source: chrome-extension://jlgnoeceollaejlkenecblnjmdcfhfgc/_generated_background_page.html (0)\n[13567:13567:0317/005848.475657:460325465:INFO:CONSOLE(0)] \"[SUCCESS] setPropertiesTest\", source: chrome-extension://jlgnoeceollaejlkenecblnjmdcfhfgc/_generated_background_page.html (0)\n[13567:13567:0317/005848.535918:460385680:INFO:CONSOLE(0)] \"[SUCCESS] setPropertiesInvalidValuesTest\", source: chrome-extension://jlgnoeceollaejlkenecblnjmdcfhfgc/_generated_background_page.html (0)\n[13567:13567:0317/005848.540736:460390496:INFO:CONSOLE(0)] \"[SUCCESS] verifyDeviceChangedEvents\", source: chrome-extension://jlgnoeceollaejlkenecblnjmdcfhfgc/_generated_background_page.html (0)\n[ OK ] WhitelistedAudioApiTest.DeprecatedApi (1914 ms)\n[8/202] WhitelistedAudioApiTest.DeprecatedApi (2130 ms)\n[ RUN ] DnsApiTest.DnsResolveIPLiteral\n\nDevTools listening on ws://127.0.0.1:44721/devtools/browser/92593a01-0b45-4d5c-9a3f-435b9f7737ab\n[ OK ] DnsApiTest.DnsResolveIPLiteral (978 ms)\n[9/202] DnsApiTest.DnsResolveIPLiteral (1338 ms)\n[ RUN ] BluetoothSocketApiTest.PermissionDenied\n\nDevTools listening on ws://127.0.0.1:36288/devtools/browser/e8a02f81-a0bf-46ff-a15e-6217bff5907b\n[13846:13846:0317/005850.049482:461899256:INFO:CONSOLE(0)] \"[SUCCESS] (no test)\", source: chrome-extension://pjdjhejcdkeebjehnokfbfnjmgmgdjlc/_generated_background_page.html (0)\n[ OK ] BluetoothSocketApiTest.PermissionDenied (1371 ms)\n[10/202] BluetoothSocketApiTest.PermissionDenied (1602 ms)\n[ RUN ] DisplaySourceApiTest.DisplaySourceExtension\n\nDevTools listening on ws://127.0.0.1:38982/devtools/browser/a5c3768f-16f6-4739-8c44-2708903981c9\n[13847:13847:0317/005850.050199:461899974:INFO:CONSOLE(0)] \"[SUCCESS] testGetAvailableSinks\", source: chrome-extension://eakonlkfnnjfnpbjnakpgifnjcdpfofn/_generated_background_page.html (0)\n[13847:13847:0317/005850.061111:461910882:INFO:CONSOLE(0)] \"[SUCCESS] testOnSinksUpdated\", source: chrome-extension://eakonlkfnnjfnpbjnakpgifnjcdpfofn/_generated_background_page.html (0)\n[13847:13847:0317/005850.070169:461919941:INFO:CONSOLE(0)] \"[SUCCESS] testRequestAuthentication\", source: chrome-extension://eakonlkfnnjfnpbjnakpgifnjcdpfofn/_generated_background_page.html (0)\n[13847:13847:0317/005850.084111:461933879:INFO:CONSOLE(0)] \"[SUCCESS] testStartSessionErrorReport\", source: chrome-extension://eakonlkfnnjfnpbjnakpgifnjcdpfofn/_generated_background_page.html (0)\n[13847:13847:0317/005850.089316:461939085:INFO:CONSOLE(0)] \"[SUCCESS] testTerminateSessionErrorReport\", source: chrome-extension://eakonlkfnnjfnpbjnakpgifnjcdpfofn/_generated_background_page.html (0)\n[13847:13896:0317/005850.128282:461978060:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] DisplaySourceApiTest.DisplaySourceExtension (1369 ms)\n[11/202] DisplaySourceApiTest.DisplaySourceExtension (1605 ms)\n[ RUN ] BluetoothSocketApiTest.Listen\n\nDevTools listening on ws://127.0.0.1:35805/devtools/browser/4a008c2c-9aa6-4b05-b480-0e509fd78a5e\n[13845:13845:0317/005850.222504:462072266:INFO:CONSOLE(0)] \"[SUCCESS] testListen\", source: chrome-extension://pjdjhejcdkeebjehnokfbfnjmgmgdjlc/_generated_background_page.html (0)\n[13845:13900:0317/005850.269898:462119665:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] BluetoothSocketApiTest.Listen (1573 ms)\n[12/202] BluetoothSocketApiTest.Listen (1862 ms)\n[ RUN ] DnsApiTest.DnsResolveHostname\n\nDevTools listening on ws://127.0.0.1:37832/devtools/browser/fba36b3e-4d5f-4ada-8af3-466b6a6d0f3a\n[14068:14109:0317/005851.031686:462881455:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] DnsApiTest.DnsResolveHostname (887 ms)\n[13/202] DnsApiTest.DnsResolveHostname (1084 ms)\n[ RUN ] FeedbackPrivateApiTest.Basic\n\nDevTools listening on ws://127.0.0.1:39144/devtools/browser/55c0242a-af20-4a51-bf40-91e33ed7c784\n[14087:14087:0317/005851.808153:463657928:INFO:CONSOLE(0)] \"[SUCCESS] getUserEmailTest\", source: chrome-extension://gfdkimpbcpahaombhbimeihdjnejgicl/_generated_background_page.html (0)\n[14087:14087:0317/005851.855398:463705168:INFO:CONSOLE(0)] \"[SUCCESS] getSystemInfoTest\", source: chrome-extension://gfdkimpbcpahaombhbimeihdjnejgicl/_generated_background_page.html (0)\n[14087:14087:0317/005851.865719:463715488:ERROR:shell_feedback_private_delegate.cc(48)] Not implemented reached in virtual void extensions::ShellFeedbackPrivateDelegate::FetchAndMergeIwlwifiDumpLogsIfPresent(std::unique_ptr<FeedbackCommon::SystemLogsMap>, content::BrowserContext *, system_logs::SysLogsFetcherCallback) const\n[14087:14087:0317/005851.874224:463723998:INFO:CONSOLE(0)] \"[SUCCESS] sendFeedbackTest\", source: chrome-extension://gfdkimpbcpahaombhbimeihdjnejgicl/_generated_background_page.html (0)\n[14087:14087:0317/005851.875158:463724926:WARNING:feedback_uploader.cc(233)] FEEDBACK: Submission to feedback server (https://www.google.com/tools/feedback/chrome/__submit) status: No connection to server.\n[ OK ] FeedbackPrivateApiTest.Basic (1558 ms)\n[14/202] FeedbackPrivateApiTest.Basic (1862 ms)\n[ RUN ] DnsApiTest.DnsExtension\n\nDevTools listening on ws://127.0.0.1:38669/devtools/browser/f76c5095-d58f-434c-a8e4-e1eef0f7285e\n[14083:14083:0317/005852.012323:463862094:INFO:CONSOLE(0)] \"[SUCCESS] testIPLiteralResolution\", source: chrome-extension://fncagodipnkiklcgjhnilcffcmnkamlo/_generated_background_page.html (0)\n[14083:14083:0317/005852.026757:463876537:INFO:CONSOLE(0)] \"[SUCCESS] testHostnameResolution\", source: chrome-extension://fncagodipnkiklcgjhnilcffcmnkamlo/_generated_background_page.html (0)\n[14083:14083:0317/005852.038402:463888178:INFO:CONSOLE(0)] \"[SUCCESS] testNonexistentHostnameResolution\", source: chrome-extension://fncagodipnkiklcgjhnilcffcmnkamlo/_generated_background_page.html (0)\n[ OK ] DnsApiTest.DnsExtension (1787 ms)\n[15/202] DnsApiTest.DnsExtension (2126 ms)\n[ RUN ] HidApiTest.HidApp\n\nDevTools listening on ws://127.0.0.1:45744/devtools/browser/4822202f-9272-451d-859b-0d3e72982f31\n[14094:14094:0317/005851.939402:463789181:INFO:CONSOLE(0)] \"[SUCCESS] testGetDevicesWithNoOptions\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005851.950299:463800070:INFO:CONSOLE(0)] \"[SUCCESS] testGetDevicesWithLegacyVidAndPid\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005851.961424:463811194:INFO:CONSOLE(0)] \"[SUCCESS] testGetDevicesWithNoFilters\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005851.968049:463817813:INFO:CONSOLE(0)] \"[SUCCESS] testGetDevicesWithVidPidFilter\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005851.977055:463826822:INFO:CONSOLE(0)] \"[SUCCESS] testGetDevicesWithUsageFilter\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005851.984276:463834046:INFO:CONSOLE(0)] \"[SUCCESS] testGetDevicesWithUnauthorizedDevice\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.046240:463896018:INFO:CONSOLE(0)] \"[SUCCESS] testDeviceInfo\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.057193:463906960:INFO:CONSOLE(0)] \"[SUCCESS] testConnectWithInvalidDeviceId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.073486:463923255:INFO:CONSOLE(0)] \"[SUCCESS] testConnectAndDisconnect\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.080157:463929925:INFO:CONSOLE(0)] \"[SUCCESS] testDisconnectWithInvalidConnectionId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.087973:463937742:INFO:CONSOLE(0)] \"[SUCCESS] testReceiveWithInvalidConnectionId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.109628:463959398:INFO:CONSOLE(0)] \"[SUCCESS] testReceiveWithReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.134329:463984099:INFO:CONSOLE(0)] \"[SUCCESS] testReceiveWithoutReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.146625:463996395:INFO:CONSOLE(0)] \"[SUCCESS] testSendWithInvalidConnectionId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.173741:464023502:INFO:CONSOLE(0)] \"[SUCCESS] testSendOversizeReport\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.189481:464039250:INFO:CONSOLE(0)] \"[SUCCESS] testSendWithReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.203373:464053156:INFO:CONSOLE(0)] \"[SUCCESS] testSendWithoutReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.218236:464067996:INFO:CONSOLE(0)] \"[SUCCESS] testSendWithInvalidReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.232722:464082493:INFO:CONSOLE(0)] \"[SUCCESS] testSendWithUnexpectedReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.239215:464088986:INFO:CONSOLE(0)] \"[SUCCESS] testReceiveFeatureReportWithInvalidConnectionId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.252080:464101841:INFO:CONSOLE(0)] \"[SUCCESS] testReceiveFeatureReportWithReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.264610:464114371:INFO:CONSOLE(0)] \"[SUCCESS] testReceiveFeatureReportWithoutReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.277693:464127466:INFO:CONSOLE(0)] \"[SUCCESS] testReceiveFeatureReportWithInvalidReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.290850:464140612:INFO:CONSOLE(0)] \"[SUCCESS] testReceiveFeatureReportWithUnexpectedReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.297147:464146909:INFO:CONSOLE(0)] \"[SUCCESS] testSendFeatureReportWithInvalidConnectionId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.319142:464168902:INFO:CONSOLE(0)] \"[SUCCESS] testSendFeatureReportWithReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.335983:464185743:INFO:CONSOLE(0)] \"[SUCCESS] testSendFeatureReportWithoutReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.356613:464206374:INFO:CONSOLE(0)] \"[SUCCESS] testSendFeatureReportWithInvalidReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14094:0317/005852.377828:464227602:INFO:CONSOLE(0)] \"[SUCCESS] testSendFeatureReportWithUnexpectedReportId\", source: chrome-extension://abdjffimllhadmhemlicclecfaihddmm/_generated_background_page.html (0)\n[14094:14151:0317/005852.424985:464274758:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] HidApiTest.HidApp (1866 ms)\n[16/202] HidApiTest.HidApp (2123 ms)\n[ RUN ] HidApiTest.OnDeviceAdded\n\nDevTools listening on ws://127.0.0.1:33139/devtools/browser/95beb9b4-3504-459b-ad32-0afd56860075\n[14195:14324:0317/005852.482511:464332272:ERROR:browser_process_sub_thread.cc(217)] Waited 10 ms for network service\n[ OK ] HidApiTest.OnDeviceAdded (1150 ms)\n[17/202] HidApiTest.OnDeviceAdded (1615 ms)\n[ RUN ] HidApiTest.OnDeviceRemoved\n\nDevTools listening on ws://127.0.0.1:44973/devtools/browser/88043c19-c3a0-4f66-baa7-e6b8de3dc705\n[ OK ] HidApiTest.OnDeviceRemoved (1190 ms)\n[18/202] HidApiTest.OnDeviceRemoved (1621 ms)\n[ RUN ] HidApiTest.GetUserSelectedDevices\n\nDevTools listening on ws://127.0.0.1:35638/devtools/browser/f24c8112-9261-4d2f-b71e-12c68d86a942\n[14386:14477:0317/005854.145532:465995302:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] HidApiTest.GetUserSelectedDevices (1680 ms)\n[19/202] HidApiTest.GetUserSelectedDevices (1860 ms)\n[ RUN ] PrinterProviderApiTest.PrintJobFailed\n\nDevTools listening on ws://127.0.0.1:39557/devtools/browser/b4142c7e-bf1a-40b8-acb7-bbee36f3bfed\n[14416:14416:0317/005854.140264:465990049:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://jmfninjglbekcffongcllfjohdefaohb/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.PrintJobFailed (1369 ms)\n[20/202] PrinterProviderApiTest.PrintJobFailed (1596 ms)\n[ RUN ] PrinterProviderApiTest.PrintJobAsyncSuccess\n\nDevTools listening on ws://127.0.0.1:34149/devtools/browser/341ae4c9-dfb7-4c49-a60d-cd91cc39affa\n[14401:14401:0317/005854.207521:466057286:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://jmfninjglbekcffongcllfjohdefaohb/_generated_background_page.html (0)\n[14401:14506:0317/005854.262145:466111906:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] PrinterProviderApiTest.PrintJobAsyncSuccess (1575 ms)\n[21/202] PrinterProviderApiTest.PrintJobAsyncSuccess (1868 ms)\n[ RUN ] PrinterProviderApiTest.NoPrintEventListener\n\nDevTools listening on ws://127.0.0.1:33001/devtools/browser/4bfb6173-0547-46a2-99d9-f79868626ac3\n[14603:14603:0317/005854.850673:466700445:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://jmfninjglbekcffongcllfjohdefaohb/_generated_background_page.html (0)\n[14603:14663:0317/005854.904769:466754537:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] PrinterProviderApiTest.NoPrintEventListener (974 ms)\n[22/202] PrinterProviderApiTest.NoPrintEventListener (1356 ms)\n[ RUN ] PrinterProviderApiTest.PrintRequestDataNotSet\n\nDevTools listening on ws://127.0.0.1:36510/devtools/browser/7c947bf0-abc0-42ec-90db-1a2ad31e6b80\n[ OK ] PrinterProviderApiTest.PrintRequestDataNotSet (1461 ms)\n[23/202] PrinterProviderApiTest.PrintRequestDataNotSet (1876 ms)\n[ RUN ] PrinterProviderApiTest.PrintRequestAppUnloaded\n\nDevTools listening on ws://127.0.0.1:38089/devtools/browser/83a79d85-a0de-49b3-a594-492c14ee339e\n[14691:14691:0317/005855.942602:467792382:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://jmfninjglbekcffongcllfjohdefaohb/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.PrintRequestAppUnloaded (1440 ms)\n[24/202] PrinterProviderApiTest.PrintRequestAppUnloaded (1875 ms)\n[ RUN ] PrinterProviderApiTest.GetCapabilitySuccess\n\nDevTools listening on ws://127.0.0.1:38049/devtools/browser/bcf9afa7-ee85-4a47-a0e1-426369492e16\n[14804:14804:0317/005856.415588:468265361:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fmcnjaijanledicomfgmdmjdlipkncao/_generated_background_page.html (0)\n[14804:14927:0317/005856.610037:468459800:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] PrinterProviderApiTest.GetCapabilitySuccess (1230 ms)\n[25/202] PrinterProviderApiTest.GetCapabilitySuccess (1643 ms)\n[ RUN ] PrinterProviderApiTest.PrintRequestInvalidCallbackParam\n\nDevTools listening on ws://127.0.0.1:46086/devtools/browser/90e532ee-022b-4a5d-a63e-beda14700733\n[14667:14667:0317/005856.067331:467917102:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://jmfninjglbekcffongcllfjohdefaohb/_generated_background_page.html (0)\n[14667:14769:0317/005856.143672:467993442:ERROR:browser_process_sub_thread.cc(217)] Waited 6 ms for network service\n[ OK ] PrinterProviderApiTest.PrintRequestInvalidCallbackParam (2206 ms)\n[26/202] PrinterProviderApiTest.PrintRequestInvalidCallbackParam (2662 ms)\n[ RUN ] PrinterProviderApiTest.GetCapabilityAsyncSuccess\n\nDevTools listening on ws://127.0.0.1:42468/devtools/browser/9415d571-2fea-4404-bedf-db26cdf0c438\n[14990:14990:0317/005857.350565:469200337:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fmcnjaijanledicomfgmdmjdlipkncao/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.GetCapabilityAsyncSuccess (1109 ms)\n[27/202] PrinterProviderApiTest.GetCapabilityAsyncSuccess (1335 ms)\n[ RUN ] PrinterProviderApiTest.EmptyCapability\n\nDevTools listening on ws://127.0.0.1:38810/devtools/browser/6c3d147c-7a35-4c33-a2f8-c045b19a6b4a\n[14991:14991:0317/005858.156217:470005992:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fmcnjaijanledicomfgmdmjdlipkncao/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.EmptyCapability (1620 ms)\n[28/202] PrinterProviderApiTest.EmptyCapability (2123 ms)\n[ RUN ] PrinterProviderApiTest.NoCapabilityEventListener\n\nDevTools listening on ws://127.0.0.1:33485/devtools/browser/02b7b5f7-5a95-44e9-806b-3c73d934f301\n[15025:15025:0317/005858.257121:470106900:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fmcnjaijanledicomfgmdmjdlipkncao/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.NoCapabilityEventListener (1452 ms)\n[29/202] PrinterProviderApiTest.NoCapabilityEventListener (1870 ms)\n[ RUN ] PrinterProviderApiTest.CapabilityInvalidValue\n\nDevTools listening on ws://127.0.0.1:34742/devtools/browser/7f16450a-a6f6-4050-b734-d0525c913e1b\n[15032:15032:0317/005858.334123:470183908:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fmcnjaijanledicomfgmdmjdlipkncao/_generated_background_page.html (0)\n[15032:15112:0317/005858.417976:470267757:ERROR:browser_process_sub_thread.cc(217)] Waited 0 ms for network service\n[ OK ] PrinterProviderApiTest.CapabilityInvalidValue (1403 ms)\n[30/202] PrinterProviderApiTest.CapabilityInvalidValue (1873 ms)\n[ RUN ] PrinterProviderApiTest.GetCapabilityAppUnloaded\n\nDevTools listening on ws://127.0.0.1:40865/devtools/browser/71eb2200-9d2a-4b07-a556-c13941ebb74f\n[15146:15146:0317/005858.823582:470673355:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fmcnjaijanledicomfgmdmjdlipkncao/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.GetCapabilityAppUnloaded (1162 ms)\n[31/202] PrinterProviderApiTest.GetCapabilityAppUnloaded (1606 ms)\n[ RUN ] PrinterProviderApiTest.GetPrintersSuccess\n\nDevTools listening on ws://127.0.0.1:36547/devtools/browser/dc4408df-db80-443c-8d92-5e2c4c5bf3c7\n[15304:15304:0317/005900.453671:472303448:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fnnlgageeedihnidgcifkdeeecafomfm/_generated_background_page.html (0)\n[15304:15375:0317/005900.515522:472365292:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] PrinterProviderApiTest.GetPrintersSuccess (1941 ms)\n[32/202] PrinterProviderApiTest.GetPrintersSuccess (2132 ms)\n[ RUN ] PrinterProviderApiTest.GetPrintersAsyncSuccess\n\nDevTools listening on ws://127.0.0.1:35777/devtools/browser/98fe3e80-4510-4d9d-994b-da7b31691604\n[15335:15335:0317/005900.580048:472429821:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fnnlgageeedihnidgcifkdeeecafomfm/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.GetPrintersAsyncSuccess (1913 ms)\n[33/202] PrinterProviderApiTest.GetPrintersAsyncSuccess (2123 ms)\n[ RUN ] PrinterProviderApiTest.GetPrintersTwoExtensions\n\nDevTools listening on ws://127.0.0.1:44503/devtools/browser/acc967b9-7b01-4218-8906-1fef0029a38f\n[15338:15338:0317/005900.714210:472563988:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://ahfhpcanhefelfnkiadilpkejbhhmghj/_generated_background_page.html (0)\n[15338:15338:0317/005900.716327:472566111:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fnnlgageeedihnidgcifkdeeecafomfm/_generated_background_page.html (0)\n[15338:15382:0317/005900.789141:472638941:ERROR:browser_process_sub_thread.cc(217)] Waited 0 ms for network service\n[ OK ] PrinterProviderApiTest.GetPrintersTwoExtensions (1889 ms)\n[34/202] PrinterProviderApiTest.GetPrintersTwoExtensions (2130 ms)\n[ RUN ] PrinterProviderApiTest.GetPrintersTwoExtensionsBothUnloaded\n\nDevTools listening on ws://127.0.0.1:38676/devtools/browser/202815d0-c2b0-4389-b47b-89f68250362c\n[15353:15353:0317/005900.986424:472836189:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://ahfhpcanhefelfnkiadilpkejbhhmghj/_generated_background_page.html (0)\n[15353:15353:0317/005900.986817:472836574:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fnnlgageeedihnidgcifkdeeecafomfm/_generated_background_page.html (0)\n[15353:15425:0317/005901.036927:472886687:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] PrinterProviderApiTest.GetPrintersTwoExtensionsBothUnloaded (1784 ms)\n[35/202] PrinterProviderApiTest.GetPrintersTwoExtensionsBothUnloaded (2123 ms)\n[ RUN ] PrinterProviderApiTest.GetPrintersTwoExtensionsOneFails\n\nDevTools listening on ws://127.0.0.1:38620/devtools/browser/1d25fb7e-291c-4fa8-9650-9f2ac6857240\n[15607:15607:0317/005902.471806:474321582:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fnnlgageeedihnidgcifkdeeecafomfm/_generated_background_page.html (0)\n[15607:15607:0317/005902.474320:474324092:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://ahfhpcanhefelfnkiadilpkejbhhmghj/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.GetPrintersTwoExtensionsOneFails (1852 ms)\n[36/202] PrinterProviderApiTest.GetPrintersTwoExtensionsOneFails (2130 ms)\n[ RUN ] PrinterProviderApiTest.GetPrintersNoListener\n\nDevTools listening on ws://127.0.0.1:42717/devtools/browser/3c29898e-8d2f-4026-ab42-79cebc8b97d5\n[15643:15643:0317/005902.579299:474429073:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fnnlgageeedihnidgcifkdeeecafomfm/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.GetPrintersNoListener (1648 ms)\n[37/202] PrinterProviderApiTest.GetPrintersNoListener (1862 ms)\n[ RUN ] PrinterProviderApiTest.GetPrintersNotArray\n\nDevTools listening on ws://127.0.0.1:36784/devtools/browser/a6dae832-61d1-4849-86de-90d823f8a3d3\n[15696:15696:0317/005902.771445:474621217:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fnnlgageeedihnidgcifkdeeecafomfm/_generated_background_page.html (0)\n[15696:15789:0317/005902.818037:474667799:ERROR:browser_process_sub_thread.cc(217)] Waited 4 ms for network service\n[ OK ] PrinterProviderApiTest.GetPrintersNotArray (1401 ms)\n[38/202] PrinterProviderApiTest.GetPrintersNotArray (1604 ms)\n[ RUN ] PrinterProviderApiTest.GetPrintersTwoExtensionsOneWithNoListener\n\nDevTools listening on ws://127.0.0.1:39641/devtools/browser/13b59a22-aba1-4283-ba0a-148274b8357b\n[15627:15627:0317/005902.558967:474408732:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fnnlgageeedihnidgcifkdeeecafomfm/_generated_background_page.html (0)\n[15627:15627:0317/005902.900542:474750315:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://ahfhpcanhefelfnkiadilpkejbhhmghj/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.GetPrintersTwoExtensionsOneWithNoListener (2094 ms)\n[39/202] PrinterProviderApiTest.GetPrintersTwoExtensionsOneWithNoListener (2393 ms)\n[ RUN ] PrinterProviderApiTest.GetPrintersInvalidPrinterValueType\n\nDevTools listening on ws://127.0.0.1:37484/devtools/browser/e9191600-7148-4968-bbb0-cbee07ce6284\n[15954:15954:0317/005904.440699:476290460:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fnnlgageeedihnidgcifkdeeecafomfm/_generated_background_page.html (0)\n[15954:16007:0317/005904.500229:476349999:ERROR:browser_process_sub_thread.cc(217)] Waited 10 ms for network service\n[ OK ] PrinterProviderApiTest.GetPrintersInvalidPrinterValueType (1670 ms)\n[40/202] PrinterProviderApiTest.GetPrintersInvalidPrinterValueType (1864 ms)\n[ RUN ] PrinterProviderApiTest.GetUsbPrinterInfo\n\nDevTools listening on ws://127.0.0.1:44880/devtools/browser/9e6a1386-c36d-4d14-b9cb-d3841a7d1e08\n[15966:15966:0317/005904.495602:476345366:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://iknlcommnonhaplfklglpgdkhecflmpa/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.GetUsbPrinterInfo (1562 ms)\n[41/202] PrinterProviderApiTest.GetUsbPrinterInfo (1862 ms)\n[ RUN ] PrinterProviderApiTest.GetPrintersInvalidPrinterValue\n\nDevTools listening on ws://127.0.0.1:43498/devtools/browser/f24da78d-5171-4dac-b6e6-4941b1b89796\n[15955:15955:0317/005904.523528:476373297:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://fnnlgageeedihnidgcifkdeeecafomfm/_generated_background_page.html (0)\n[15955:16015:0317/005904.588765:476438526:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] PrinterProviderApiTest.GetPrintersInvalidPrinterValue (1726 ms)\n[42/202] PrinterProviderApiTest.GetPrintersInvalidPrinterValue (2124 ms)\n[ RUN ] PrinterProviderApiTest.GetUsbPrinterInfoEmptyResponse\n\nDevTools listening on ws://127.0.0.1:32855/devtools/browser/33524136-dfb0-4ae6-b935-8be877537e79\n[15982:15982:0317/005904.659862:476509637:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://iknlcommnonhaplfklglpgdkhecflmpa/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.GetUsbPrinterInfoEmptyResponse (1457 ms)\n[43/202] PrinterProviderApiTest.GetUsbPrinterInfoEmptyResponse (1859 ms)\n[ RUN ] SocketApiTest.SocketUDPCreateGood\n\nDevTools listening on ws://127.0.0.1:43245/devtools/browser/9460e4c3-2d13-4f63-8478-d2ce383222a4\n[ OK ] SocketApiTest.SocketUDPCreateGood (913 ms)\n[44/202] SocketApiTest.SocketUDPCreateGood (1074 ms)\n[ RUN ] SocketApiTest.SocketTCPCreateGood\n\nDevTools listening on ws://127.0.0.1:35659/devtools/browser/77a7c6e0-2c3f-4de5-96aa-d673edc5954a\n[ OK ] SocketApiTest.SocketTCPCreateGood (744 ms)\n[45/202] SocketApiTest.SocketTCPCreateGood (947 ms)\n[ RUN ] SocketApiTest.GetNetworkList\n\nDevTools listening on ws://127.0.0.1:33998/devtools/browser/3258bb15-19aa-4619-b6c8-5579815dcd51\n[16248:16291:0317/005906.055556:477905333:ERROR:browser_process_sub_thread.cc(217)] Waited 9 ms for network service\n[ OK ] SocketApiTest.GetNetworkList (961 ms)\n[46/202] SocketApiTest.GetNetworkList (1334 ms)\n[ RUN ] PrinterProviderApiTest.GetUsbPrinterInfoNoListener\n\nDevTools listening on ws://127.0.0.1:43112/devtools/browser/bc473555-d053-4944-9270-3333753012ac\n[16233:16233:0317/005906.351982:478201768:INFO:CONSOLE(0)] \"[SUCCESS] printTest\", source: chrome-extension://iknlcommnonhaplfklglpgdkhecflmpa/_generated_background_page.html (0)\n[ OK ] PrinterProviderApiTest.GetUsbPrinterInfoNoListener (2267 ms)\n[47/202] PrinterProviderApiTest.GetUsbPrinterInfoNoListener (2650 ms)\n[ RUN ] SocketsTcpApiTest.SocketsTcpCreateGood\n\nDevTools listening on ws://127.0.0.1:42902/devtools/browser/14a1a39f-62ba-4891-9ccd-5f22c863973e\n[16362:16443:0317/005907.039853:478889614:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] SocketsTcpApiTest.SocketsTcpCreateGood (1374 ms)\n[48/202] SocketsTcpApiTest.SocketsTcpCreateGood (1731 ms)\n[ RUN ] SocketsTcpServerApiTest.SocketTCPCreateGood\n\nDevTools listening on ws://127.0.0.1:45002/devtools/browser/92e91413-5703-40e5-9d4b-253dae6af928\n[ OK ] SocketsTcpServerApiTest.SocketTCPCreateGood (939 ms)\n[49/202] SocketsTcpServerApiTest.SocketTCPCreateGood (1335 ms)\n[ RUN ] SocketsTcpApiTest.SocketTcpExtension\n\nDevTools listening on ws://127.0.0.1:43553/devtools/browser/1f994978-113f-4db6-942d-15a1f9758b74\nEcho TCP server started on port 43760...\nsending server_data: {\"host\": \"127.0.0.1\", \"port\": 43760} (36 bytes)\n[16345:16345:0317/005908.557633:480407420:INFO:CONSOLE(442)] \"Running tests for TCP, echo server www.foo.com:43760\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (442)\n[16345:16345:0317/005908.587649:480437423:INFO:CONSOLE(0)] \"[SUCCESS] testSocketCreation\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/_generated_background_page.html (0)\n[16345:16345:0317/005908.589387:480439157:INFO:CONSOLE(0)] \"Unchecked runtime.lastError: Socket not found\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/_generated_background_page.html (0)\n[16345:16345:0317/005908.595884:480445655:INFO:CONSOLE(121)] \"onCreateComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (121)\n[16345:16345:0317/005908.596679:480446450:INFO:CONSOLE(125)] \"add event listeners\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (125)\n[16345:16345:0317/005908.599564:480449356:INFO:CONSOLE(135)] \"onGetInfoAfterCreateComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (135)\n[16345:16345:0317/005908.606249:480456045:INFO:CONSOLE(160)] \"onUpdateComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (160)\n[16345:16345:0317/005908.608863:480458624:INFO:CONSOLE(165)] \"onGetInfoAfterUpdateComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (165)\n[16345:16345:0317/005908.621548:480471326:INFO:CONSOLE(188)] \"onConnectComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (188)\n[16345:16345:0317/005908.625690:480475464:INFO:CONSOLE(196)] \"onGetInfoAfterConnectComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (196)\n[16345:16345:0317/005908.631515:480481281:INFO:CONSOLE(214)] \"onSetPausedComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (214)\n[16345:16345:0317/005908.636362:480486132:INFO:CONSOLE(219)] \"onGetInfoAfterSetPausedComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (219)\n[16345:16345:0317/005908.638619:480488386:INFO:CONSOLE(225)] \"onUnpauseComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (225)\n[16345:16345:0317/005908.641284:480491053:INFO:CONSOLE(230)] \"onGetInfoAfterUnpauseComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (230)\n[16345:16345:0317/005908.646689:480496459:INFO:CONSOLE(236)] \"onSetNoDelayComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (236)\n[16345:16345:0317/005908.649539:480499327:INFO:CONSOLE(247)] \"onSetKeepAliveComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (247)\n[16345:16345:0317/005908.664860:480514621:INFO:CONSOLE(261)] \"onSendComplete: 24 bytes.\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (261)\n[16345:16345:0317/005908.669488:480519249:INFO:CONSOLE(269)] \"onSocketReceive\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (269)\n[16345:16345:0317/005908.681224:480530992:INFO:CONSOLE(275)] \"echo data received, closing socket\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (275)\n[16345:16345:0317/005908.683870:480533642:INFO:CONSOLE(294)] \"onCloseComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (294)\n[16345:16345:0317/005908.684531:480534301:INFO:CONSOLE(0)] \"[SUCCESS] testSending\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/_generated_background_page.html (0)\n[ OK ] SocketsTcpApiTest.SocketTcpExtension (2680 ms)\n[50/202] SocketsTcpApiTest.SocketTcpExtension (3037 ms)\n[ RUN ] SocketsTcpApiTest.SocketTcpExtensionTLS\n\nDevTools listening on ws://127.0.0.1:42738/devtools/browser/7508938c-37c8-4cdf-80a2-6769c4021608\nHTTPS server started on https://127.0.0.1:34185...\nsending server_data: {\"host\": \"127.0.0.1\", \"port\": 34185} (36 bytes)\n[16416:16416:0317/005908.525433:480375198:INFO:CONSOLE(448)] \"Running tests for HTTPS, server 127.0.0.1:34185\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (448)\n[16416:16416:0317/005908.544785:480394545:INFO:CONSOLE(339)] \"HTTPS onPausedComplete. Connecting to 127.0.0.1:34185\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (339)\n[16416:16416:0317/005908.552408:480402169:INFO:CONSOLE(346)] \"HTTPS onConnectComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (346)\n[16416:16416:0317/005908.628357:480478131:INFO:CONSOLE(353)] \"HTTPS onSecureComplete(0)\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (353)\n[16416:16416:0317/005908.631364:480481137:INFO:CONSOLE(367)] \"HTTPS onUnpauseComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (367)\n[16416:16416:0317/005908.646399:480496170:INFO:CONSOLE(375)] \"HTTPS onSendComplete: 26 bytes.\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (375)\n[16416:16416:0317/005908.656346:480506115:INFO:CONSOLE(383)] \"HTTPS onSocketReceive\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (383)\n[16416:16416:0317/005908.662316:480512090:INFO:CONSOLE(383)] \"HTTPS onSocketReceive\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (383)\n[16416:16416:0317/005908.667954:480517717:INFO:CONSOLE(402)] \"HTTPS onSocketReceiveError\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (402)\n[16416:16416:0317/005908.670478:480520246:INFO:CONSOLE(391)] \"HTTPS receive: got HTTP/1.0 200 OK\n\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (391)\n[16416:16416:0317/005908.672330:480522101:INFO:CONSOLE(394)] \"HTTPS response received, closing socket.\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (394)\n[16416:16416:0317/005908.675023:480524796:INFO:CONSOLE(411)] \"HTTPS Test Succeeded\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (411)\n[16416:16416:0317/005908.678054:480527946:INFO:CONSOLE(330)] \"HTTPS onCreateComplete: in MISUSE_SECURE_PENDING_READ mode, skipping setPaused(false).\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (330)\n[16416:16416:0317/005908.678611:480528503:INFO:CONSOLE(339)] \"HTTPS onPausedComplete. Connecting to 127.0.0.1:34185\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (339)\n[16416:16416:0317/005908.687889:480537659:INFO:CONSOLE(346)] \"HTTPS onConnectComplete\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (346)\n[16416:16416:0317/005908.691348:480541108:INFO:CONSOLE(402)] \"HTTPS onSocketReceiveError\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (402)\n[16416:16416:0317/005908.696263:480546024:INFO:CONSOLE(353)] \"HTTPS onSecureComplete(-2)\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (353)\n[16416:16416:0317/005908.697967:480548048:INFO:CONSOLE(0)] \"Unchecked runtime.lastError: net::ERR_FAILED\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/_generated_background_page.html (0)\n[16416:16416:0317/005908.699846:480549606:INFO:CONSOLE(411)] \"HTTPS Test Succeeded\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/background.js (411)\n[16416:16416:0317/005908.701305:480551073:INFO:CONSOLE(0)] \"[SUCCESS] testSecure\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/_generated_background_page.html (0)\n[16416:16416:0317/005908.702682:480552450:INFO:CONSOLE(0)] \"Unchecked runtime.lastError: Socket not found\", source: chrome-extension://poppegbdkmfildfgekgnkhhbhnkndnka/_generated_background_page.html (0)\n[ OK ] SocketsTcpApiTest.SocketTcpExtensionTLS (2301 ms)\n[51/202] SocketsTcpApiTest.SocketTcpExtensionTLS (2658 ms)\n[ RUN ] SocketsTcpServerApiTest.SocketTCPServerExtension\n\nDevTools listening on ws://127.0.0.1:39597/devtools/browser/d6301c24-541f-4b23-8c1a-4c3e6c5b0713\n[16568:16568:0317/005908.757037:480606808:INFO:CONSOLE(125)] \"Running tests, protocol tcp_server, echo server 127.0.0.1:8888\", source: chrome-extension://maapjikibbpceckgjljajhegnpceikmc/background.js (125)\n[16568:16568:0317/005908.774834:480624604:INFO:CONSOLE(44)] \"Server socket created: sd=1\", source: chrome-extension://maapjikibbpceckgjljajhegnpceikmc/background.js (44)\n[16568:16568:0317/005908.780070:480629841:INFO:CONSOLE(50)] \"Server socket 'listen' completed: sd=1, result=0\", source: chrome-extension://maapjikibbpceckgjljajhegnpceikmc/background.js (50)\n[16568:16568:0317/005908.786435:480636207:INFO:CONSOLE(59)] \"Client socket created: sd=1\", source: chrome-extension://maapjikibbpceckgjljajhegnpceikmc/background.js (59)\n[16568:16568:0317/005908.796230:480646004:INFO:CONSOLE(83)] \"Server socket 'accept' event: sd=1, client sd=2\", source: chrome-extension://maapjikibbpceckgjljajhegnpceikmc/background.js (83)\n[16568:16568:0317/005908.799720:480649481:INFO:CONSOLE(63)] \"Client socket connected: sd=1\", source: chrome-extension://maapjikibbpceckgjljajhegnpceikmc/background.js (63)\n[16568:16568:0317/005908.813417:480663189:INFO:CONSOLE(69)] \"Client socket data sent: sd=1, result=0\", source: chrome-extension://maapjikibbpceckgjljajhegnpceikmc/background.js (69)\n[16568:16568:0317/005908.815938:480665705:INFO:CONSOLE(92)] \"Client socket 'receive' event: sd=2, bytes=24\", source: chrome-extension://maapjikibbpceckgjljajhegnpceikmc/background.js (92)\n[16568:16568:0317/005908.822571:480672343:INFO:CONSOLE(114)] \"Client socket 'receive error' event: sd=1, result=-100\", source: chrome-extension://maapjikibbpceckgjljajhegnpceikmc/background.js (114)\n[16568:16568:0317/005908.823524:480673282:INFO:CONSOLE(72)] \"Client socket disconnected: sd=1\", source: chrome-extension://maapjikibbpceckgjljajhegnpceikmc/background.js (72)\n[16568:16568:0317/005908.825933:480675691:INFO:CONSOLE(114)] \"Client socket 'receive error' event: sd=2, result=-100\", source: chrome-extension://maapjikibbpceckgjljajhegnpceikmc/background.js (114)\n[16568:16568:0317/005909.334513:481184305:INFO:CONSOLE(0)] \"[SUCCESS] testSocketListening\", source: chrome-extension://maapjikibbpceckgjljajhegnpceikmc/_generated_background_page.html (0)\n[ OK ] SocketsTcpServerApiTest.SocketTCPServerExtension (1731 ms)\n[52/202] SocketsTcpServerApiTest.SocketTCPServerExtension (2123 ms)\n[ RUN ] SocketsUdpApiTest.SocketsUdpCreateGood\n\nDevTools listening on ws://127.0.0.1:41795/devtools/browser/3c99a17f-fed4-4523-882f-4a9b060610dc\n[16708:16738:0317/005909.731312:481581073:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] SocketsUdpApiTest.SocketsUdpCreateGood (1060 ms)\n[53/202] SocketsUdpApiTest.SocketsUdpCreateGood (1336 ms)\n[ RUN ] SystemDisplayApiTest.SetDisplayNotKioskEnabled\n\nDevTools listening on ws://127.0.0.1:39184/devtools/browser/b91d83ed-df08-411c-86ee-12e2bda95afa\n[ OK ] SystemDisplayApiTest.SetDisplayNotKioskEnabled (612 ms)\n[54/202] SystemDisplayApiTest.SetDisplayNotKioskEnabled (974 ms)\n[ RUN ] SystemDisplayApiTest.SetDisplayKioskEnabled\n\nDevTools listening on ws://127.0.0.1:34910/devtools/browser/413052be-a477-4407-bfe4-fb8e405ec4b4\n[ OK ] SystemDisplayApiTest.SetDisplayKioskEnabled (584 ms)\n[55/202] SystemDisplayApiTest.SetDisplayKioskEnabled (854 ms)\n[ RUN ] SystemDisplayApiTest.GetDisplayInfo\n\nDevTools listening on ws://127.0.0.1:46625/devtools/browser/91070c84-7243-4c40-ae2f-7c6f74b9763c\n[16723:16723:0317/005910.916499:482766275:INFO:CONSOLE(0)] \"[SUCCESS] testGet\", source: chrome-extension://bkinmoclckljagifknhkidpikmgdllbj/_generated_background_page.html (0)\n[16723:16775:0317/005910.967711:482817472:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] SystemDisplayApiTest.GetDisplayInfo (1870 ms)\n[56/202] SystemDisplayApiTest.GetDisplayInfo (2128 ms)\n[ RUN ] SystemCpuApiTest.Cpu\n\nDevTools listening on ws://127.0.0.1:45010/devtools/browser/8d005d9a-720f-47eb-a55f-9befd2fb7c67\n[16721:16721:0317/005910.957956:482807727:INFO:CONSOLE(0)] \"[SUCCESS] testGet\", source: chrome-extension://ajldehohkfhkledlcpchnlcbabmklola/_generated_background_page.html (0)\n[ OK ] SystemCpuApiTest.Cpu (2038 ms)\n[57/202] SystemCpuApiTest.Cpu (2388 ms)\n[ RUN ] SystemDisplayApiTest.EnableUnifiedDesktop\n\nDevTools listening on ws://127.0.0.1:42005/devtools/browser/28160297-fd4f-405e-8b31-92a58e41549f\n[16942:16942:0317/005911.799234:483649014:ERROR:device_event_log_impl.cc(159)] [00:59:11.799] Network: device_event_log.cc:122 @@@ Slow method: ../../chromeos/network/network_state_handler.cc:ManagedStateListChanged: 70ms\n[ OK ] SystemDisplayApiTest.EnableUnifiedDesktop (1049 ms)\n[58/202] SystemDisplayApiTest.EnableUnifiedDesktop (1354 ms)\n[ RUN ] SystemDisplayApiTest.OverscanCalibrationStart\n\nDevTools listening on ws://127.0.0.1:33448/devtools/browser/cdb8e170-172e-4419-ab10-5b1d0c0559ca\n[ OK ] SystemDisplayApiTest.OverscanCalibrationStart (979 ms)\n[59/202] SystemDisplayApiTest.OverscanCalibrationStart (1347 ms)\n[ RUN ] SystemDisplayApiTest.OverscanCalibrationApp\n\nDevTools listening on ws://127.0.0.1:42326/devtools/browser/07d7f59a-8894-48ac-8099-2e71d3494666\n[ OK ] SystemDisplayApiTest.OverscanCalibrationApp (1420 ms)\n[60/202] SystemDisplayApiTest.OverscanCalibrationApp (1602 ms)\n[ RUN ] SystemDisplayApiTest.OverscanCalibrationAppNoComplete\n\nDevTools listening on ws://127.0.0.1:43744/devtools/browser/6afa8b42-5c60-4ef3-a276-de55e37b9455\n[16972:17035:0317/005912.683396:484533165:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] SystemDisplayApiTest.OverscanCalibrationAppNoComplete (1338 ms)\n[61/202] SystemDisplayApiTest.OverscanCalibrationAppNoComplete (1600 ms)\n[ RUN ] SystemDisplayApiTest.ShowNativeTouchCalibrationFail\n\nDevTools listening on ws://127.0.0.1:39590/devtools/browser/687a6e6f-2e58-4684-a2da-9f55ec040b5d\n[ OK ] SystemDisplayApiTest.ShowNativeTouchCalibrationFail (628 ms)\n[62/202] SystemDisplayApiTest.ShowNativeTouchCalibrationFail (1019 ms)\n[ RUN ] SystemDisplayApiTest.ShowNativeTouchCalibration\n\nDevTools listening on ws://127.0.0.1:40801/devtools/browser/396ca573-9e00-475e-a611-116af8ece55d\n[ OK ] SystemDisplayApiTest.ShowNativeTouchCalibration (623 ms)\n[63/202] SystemDisplayApiTest.ShowNativeTouchCalibration (1012 ms)\n[ RUN ] SystemDisplayApiTest.SetMirrorMode\n\nDevTools listening on ws://127.0.0.1:36351/devtools/browser/875aac35-dbed-409a-9ce1-f2cc93a5cc69\n[ OK ] SystemDisplayApiTest.SetMirrorMode (1235 ms)\n[64/202] SystemDisplayApiTest.SetMirrorMode (1604 ms)\n[ RUN ] SystemNetworkApiTest.SystemNetworkExtension\n\nDevTools listening on ws://127.0.0.1:40294/devtools/browser/271c7d26-068e-4f5a-aae1-1bae11b5833b\n[17225:17225:0317/005914.661587:486511356:INFO:CONSOLE(0)] \"[SUCCESS] testGetNetworkInterfaces\", source: chrome-extension://peploceeopidapgkpigbcghejkiefdof/_generated_background_page.html (0)\n[ OK ] SystemNetworkApiTest.SystemNetworkExtension (1557 ms)\n[65/202] SystemNetworkApiTest.SystemNetworkExtension (1868 ms)\n[ RUN ] SystemMemoryApiTest.Memory\n\nDevTools listening on ws://127.0.0.1:46677/devtools/browser/e7471c73-a660-40c1-9f5d-49a808ef027a\n[17218:17218:0317/005914.824760:486674533:INFO:CONSOLE(0)] \"[SUCCESS] testGet\", source: chrome-extension://cdmnihblblmdllfcfaghdgelichpoigg/_generated_background_page.html (0)\n[ OK ] SystemMemoryApiTest.Memory (1838 ms)\n[66/202] SystemMemoryApiTest.Memory (2138 ms)\n[ RUN ] SystemStorageApiTest.Storage\n\nDevTools listening on ws://127.0.0.1:35522/devtools/browser/dda97283-ca28-47a0-a848-4465fc7b6049\n[17239:17239:0317/005914.727913:486577683:INFO:CONSOLE(0)] \"[SUCCESS] testGetInfo\", source: chrome-extension://lcjpjopkpfobeicjahdpdimkgpbniedm/_generated_background_page.html (0)\n[17239:17239:0317/005914.743272:486593039:INFO:CONSOLE(0)] \"[SUCCESS] testGetAvailableCapacity\", source: chrome-extension://lcjpjopkpfobeicjahdpdimkgpbniedm/_generated_background_page.html (0)\n[17239:17284:0317/005914.795203:486644962:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] SystemStorageApiTest.Storage (1559 ms)\n[67/202] SystemStorageApiTest.Storage (1894 ms)\n[ RUN ] SystemStorageApiTest.StorageAttachment\n\nDevTools listening on ws://127.0.0.1:42423/devtools/browser/66613710-0995-4a74-9b23-8218e852ef1e\n[17410:17410:0317/005915.585172:487434945:INFO:CONSOLE(0)] \"[SUCCESS] testAttachedEvent\", source: chrome-extension://jjlpgnokdbmbdepnoeedenkmejahomlj/_generated_background_page.html (0)\n[17410:17410:0317/005915.596744:487446513:INFO:CONSOLE(0)] \"[SUCCESS] testDetachedEvent\", source: chrome-extension://jjlpgnokdbmbdepnoeedenkmejahomlj/_generated_background_page.html (0)\n[ OK ] SystemStorageApiTest.StorageAttachment (1126 ms)\n[68/202] SystemStorageApiTest.StorageAttachment (1631 ms)\n[ RUN ] SystemStorageEjectApiTest.EjectBadDeviceTest\n\nDevTools listening on ws://127.0.0.1:38297/devtools/browser/422b793e-56ae-4a12-b2bd-94a92556f709\n[17489:17563:0317/005916.502792:488352553:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] SystemStorageEjectApiTest.EjectBadDeviceTest (1396 ms)\n[69/202] SystemStorageEjectApiTest.EjectBadDeviceTest (1602 ms)\n[ RUN ] SystemStorageEjectApiTest.EjectTest\n\nDevTools listening on ws://127.0.0.1:46844/devtools/browser/306684fa-a9e0-4a16-89d2-15310c754fb8\n[ OK ] SystemStorageEjectApiTest.EjectTest (1639 ms)\n[70/202] SystemStorageEjectApiTest.EjectTest (1863 ms)\n[ RUN ] UsbApiTest.DeviceHandling\n\nDevTools listening on ws://127.0.0.1:34756/devtools/browser/a4b3967b-9288-432c-8b6f-ca41a02266d9\n[17493:17493:0317/005916.507424:488357199:INFO:CONSOLE(0)] \"[SUCCESS] getDevices\", source: chrome-extension://oimogkhbfjpjlbhdedioaaiopoiblomi/_generated_background_page.html (0)\n[17493:17493:0317/005916.530532:488380304:INFO:CONSOLE(0)] \"[SUCCESS] getConfigurations\", source: chrome-extension://oimogkhbfjpjlbhdedioaaiopoiblomi/_generated_background_page.html (0)\n[17493:17493:0317/005916.535511:488385273:INFO:CONSOLE(0)] \"[SUCCESS] explicitCloseDevice\", source: chrome-extension://oimogkhbfjpjlbhdedioaaiopoiblomi/_generated_background_page.html (0)\n[ OK ] UsbApiTest.DeviceHandling (1435 ms)\n[71/202] UsbApiTest.DeviceHandling (1865 ms)\n[ RUN ] UsbApiTest.ResetDevice\n\nDevTools listening on ws://127.0.0.1:46416/devtools/browser/743ee96b-ad5e-48a6-ba2f-cccd26119b25\n[17619:17619:0317/005917.160574:489010349:INFO:CONSOLE(0)] \"[SUCCESS] resetDevice\", source: chrome-extension://cagkpdoidbnhhpebmmjlecneljcemoma/_generated_background_page.html (0)\n[17619:17732:0317/005917.207061:489056823:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] UsbApiTest.ResetDevice (1031 ms)\n[72/202] UsbApiTest.ResetDevice (1398 ms)\n[ RUN ] UsbApiTest.SetConfiguration\n\nDevTools listening on ws://127.0.0.1:33469/devtools/browser/f5105bff-a2f2-49f0-a9f3-33c05d7efdf4\n[17749:17749:0317/005918.111148:489960922:INFO:CONSOLE(0)] \"[SUCCESS] setConfiguration\", source: chrome-extension://ckcmgoddccbfdhcclolpemoikdlfalef/_generated_background_page.html (0)\n[ OK ] UsbApiTest.SetConfiguration (1431 ms)\n[73/202] UsbApiTest.SetConfiguration (1879 ms)\n[ RUN ] UsbApiTest.ListInterfaces\n\nDevTools listening on ws://127.0.0.1:38810/devtools/browser/27b511a7-5bf0-42f4-a1ca-e96c7637f973\n[17763:17763:0317/005918.418523:490268297:INFO:CONSOLE(0)] \"[SUCCESS] listInterfaces\", source: chrome-extension://ineijkcbfhdikcboocllcejimmhhnebn/_generated_background_page.html (0)\n[ OK ] UsbApiTest.ListInterfaces (1557 ms)\n[74/202] UsbApiTest.ListInterfaces (1875 ms)\n[ RUN ] UsbApiTest.TransferEvent\n\nDevTools listening on ws://127.0.0.1:42235/devtools/browser/627f2a6c-5a52-4faf-a644-42b2bd37485b\n[17792:17792:0317/005918.447557:490297333:INFO:CONSOLE(0)] \"[SUCCESS] controlTransfer\", source: chrome-extension://gdicjfjadakkdflaaacoojocdddlfcde/_generated_background_page.html (0)\n[17792:17792:0317/005918.476810:490326589:INFO:CONSOLE(0)] \"[SUCCESS] bulkTransfer\", source: chrome-extension://gdicjfjadakkdflaaacoojocdddlfcde/_generated_background_page.html (0)\n[17792:17792:0317/005918.492607:490342369:INFO:CONSOLE(0)] \"[SUCCESS] interruptTransfer\", source: chrome-extension://gdicjfjadakkdflaaacoojocdddlfcde/_generated_background_page.html (0)\n[17792:17792:0317/005918.504355:490354116:INFO:CONSOLE(0)] \"[SUCCESS] isochronousTransfer\", source: chrome-extension://gdicjfjadakkdflaaacoojocdddlfcde/_generated_background_page.html (0)\n[ OK ] UsbApiTest.TransferEvent (1542 ms)\n[75/202] UsbApiTest.TransferEvent (1867 ms)\n[ RUN ] UsbApiTest.ZeroLengthTransfer\n\nDevTools listening on ws://127.0.0.1:40070/devtools/browser/be401e57-7ee9-4e7a-b873-3386b0e7bab4\n[17834:17834:0317/005918.227370:490077143:ERROR:device_event_log_impl.cc(159)] [00:59:18.227] Network: device_event_log.cc:122 @@@ Slow method: ../../chromeos/network/network_state_handler.cc:NotifyNetworkConnectionStateChanged: 51ms\n[17834:17834:0317/005918.688780:490538549:INFO:CONSOLE(0)] \"[SUCCESS] zeroLengthTransfer\", source: chrome-extension://ilbmbaodnpbmlnfajeogckkbhbmfhgkj/_generated_background_page.html (0)\n[17834:17992:0317/005918.736534:490586302:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] UsbApiTest.ZeroLengthTransfer (1249 ms)\n[76/202] UsbApiTest.ZeroLengthTransfer (1605 ms)\n[ RUN ] UsbApiTest.TransferFailure\n\nDevTools listening on ws://127.0.0.1:45012/devtools/browser/7cb3b3e6-e321-43db-8f3a-8ee137355590\n[18062:18062:0317/005920.004329:491854099:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://jfbocmapdffdpambggllmfoaphmaboac/_generated_background_page.html (0)\n[18062:18062:0317/005920.024024:491873795:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://jfbocmapdffdpambggllmfoaphmaboac/_generated_background_page.html (0)\n[18062:18062:0317/005920.039405:491889178:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://jfbocmapdffdpambggllmfoaphmaboac/_generated_background_page.html (0)\n[18062:18062:0317/005920.059063:491908836:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://jfbocmapdffdpambggllmfoaphmaboac/_generated_background_page.html (0)\n[18062:18062:0317/005920.075658:491925426:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://jfbocmapdffdpambggllmfoaphmaboac/_generated_background_page.html (0)\n[18062:18094:0317/005920.141781:491991554:ERROR:browser_process_sub_thread.cc(217)] Waited 0 ms for network service\n[ OK ] UsbApiTest.TransferFailure (1560 ms)\n[77/202] UsbApiTest.TransferFailure (1870 ms)\n[ RUN ] UsbApiTest.OnDeviceAdded\n\nDevTools listening on ws://127.0.0.1:35239/devtools/browser/a126473f-4320-4ba5-b75b-350f9e7e72f2\n[ OK ] UsbApiTest.OnDeviceAdded (1421 ms)\n[78/202] UsbApiTest.OnDeviceAdded (1598 ms)\n[ RUN ] UsbApiTest.InvalidTimeout\n\nDevTools listening on ws://127.0.0.1:43660/devtools/browser/00e1d752-a88b-401c-b167-c639be7c4bfa\n[18077:18077:0317/005920.331505:492181279:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://amdhgpkfemkjpgnomphgbcipfmgmdehp/_generated_background_page.html (0)\n[18077:18077:0317/005920.344914:492194689:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://amdhgpkfemkjpgnomphgbcipfmgmdehp/_generated_background_page.html (0)\n[18077:18077:0317/005920.354720:492204483:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://amdhgpkfemkjpgnomphgbcipfmgmdehp/_generated_background_page.html (0)\n[18077:18077:0317/005920.365999:492215773:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://amdhgpkfemkjpgnomphgbcipfmgmdehp/_generated_background_page.html (0)\n[18077:18142:0317/005920.416781:492266558:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] UsbApiTest.InvalidTimeout (1561 ms)\n[79/202] UsbApiTest.InvalidTimeout (1867 ms)\n[ RUN ] UsbApiTest.InvalidLengthTransfer\n\nDevTools listening on ws://127.0.0.1:46802/devtools/browser/b93e9104-376f-4067-a025-f0a745514c76\n[18073:18073:0317/005920.292538:492142312:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[18073:18073:0317/005920.303872:492153632:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[18073:18073:0317/005920.327101:492176863:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[18073:18073:0317/005920.338846:492188614:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[18073:18073:0317/005920.350074:492199844:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[18073:18073:0317/005920.361939:492211711:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[18073:18073:0317/005920.370852:492220621:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[18073:18073:0317/005920.381172:492230941:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[18073:18073:0317/005920.395441:492245211:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[18073:18073:0317/005920.405498:492255270:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[18073:18073:0317/005920.418220:492267994:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[18073:18073:0317/005920.427536:492277309:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[18073:18073:0317/005920.437285:492287056:INFO:CONSOLE(0)] \"[SUCCESS] undefined\", source: chrome-extension://clfafekapmkhhibalmodfbifgldpifob/_generated_background_page.html (0)\n[ OK ] UsbApiTest.InvalidLengthTransfer (1752 ms)\n[80/202] UsbApiTest.InvalidLengthTransfer (2124 ms)\n[ RUN ] ExtensionBrowsertestUtilTest.ExecuteScriptInBackgroundPageNoWait\n\nDevTools listening on ws://127.0.0.1:38810/devtools/browser/2e03ecd0-011a-439c-ae22-9726ea806a98\n[ OK ] ExtensionBrowsertestUtilTest.ExecuteScriptInBackgroundPageNoWait (1405 ms)\n[81/202] ExtensionBrowsertestUtilTest.ExecuteScriptInBackgroundPageNoWait (1600 ms)\n[ RUN ] UsbApiTest.GetUserSelectedDevices\n\nDevTools listening on ws://127.0.0.1:40380/devtools/browser/f916cd5e-f046-424a-a377-0b391a598bc8\n[ OK ] UsbApiTest.GetUserSelectedDevices (1713 ms)\n[82/202] UsbApiTest.GetUserSelectedDevices (1865 ms)\n[ RUN ] UsbApiTest.OnDeviceRemoved\n\nDevTools listening on ws://127.0.0.1:42487/devtools/browser/06365162-987b-4ae8-afa7-5cc991022449\n[ OK ] UsbApiTest.OnDeviceRemoved (1700 ms)\n[83/202] UsbApiTest.OnDeviceRemoved (2125 ms)\n[ RUN ] ExtensionBrowsertestUtilTest.ExecuteScriptInBackgroundPage\n\nDevTools listening on ws://127.0.0.1:43001/devtools/browser/929b83cc-83ff-454b-8927-5fc97d2deeeb\n[ OK ] ExtensionBrowsertestUtilTest.ExecuteScriptInBackgroundPage (1575 ms)\n[84/202] ExtensionBrowsertestUtilTest.ExecuteScriptInBackgroundPage (1880 ms)\n[ RUN ] AppViewTest.TestAppViewGoodDataShouldSucceed\n\nDevTools listening on ws://127.0.0.1:39389/devtools/browser/3ebd7266-7558-4243-a5f9-4fdf815011e2\n[18607:18607:0317/005923.256326:495106099:WARNING:shell_extension_loader.cc(49)] Warnings loading extension at /b/s/w/ir/extensions/test/data/app_view/apitest/skeleton:\n[18607:18607:0317/005923.256465:495106232:WARNING:shell_extension_loader.cc(52)] Unrecognized manifest key 'minimum_chrome_version'.\n[18607:18607:0317/005924.600911:496450687:INFO:CONSOLE(20)] \"appToEmbed afbbknndjeagpaekchjbbdmgnmhpeomh\", source: chrome-extension://edgmjfmjpplaibnccnlbgaaakabpghcm/main.js (20)\n[18607:18607:0317/005924.695141:496544916:INFO:CONSOLE(20)] \"Attempting to connect to app with good params.\", source: chrome-extension://edgmjfmjpplaibnccnlbgaaakabpghcm/main.js (20)\n[18607:18607:0317/005925.340786:497190563:INFO:CONSOLE(20)] \"Connected.\", source: chrome-extension://edgmjfmjpplaibnccnlbgaaakabpghcm/main.js (20)\n[ OK ] AppViewTest.TestAppViewGoodDataShouldSucceed (3055 ms)\n[85/202] AppViewTest.TestAppViewGoodDataShouldSucceed (3437 ms)\n[ RUN ] WebViewAPITest.EmbedderVisibilityChanged\n\nDevTools listening on ws://127.0.0.1:40765/devtools/browser/ee56b4a8-90c0-461f-9e5e-93d46940de96\n[18610:18610:0317/005925.426836:497276619:INFO:CONSOLE(6)] \"onAppCommand: hide-embedder\", source: chrome-extension://njoflokikcjbllkjjimeagdoledhbija/main.js (6)\n[ OK ] WebViewAPITest.EmbedderVisibilityChanged (3017 ms)\n[86/202] WebViewAPITest.EmbedderVisibilityChanged (3451 ms)\n[ RUN ] WebViewAPITest.DisplayNoneSetSrc\n[18613:18613:0317/005923.284011:495133776:ERROR:device_event_log_impl.cc(159)] [00:59:23.283] Network: device_event_log.cc:122 @@@ Slow method: ../../chromeos/network/network_state_handler.cc:ManagedStateListChanged: 53ms\n\nDevTools listening on ws://127.0.0.1:38452/devtools/browser/cae288fc-3d1d-408d-bb47-0ebbbac0e1e3\n[18613:18613:0317/005924.936757:496786530:INFO:CONSOLE(6)] \"onAppCommand: navigate-guest\", source: chrome-extension://fmgpgbkijfkhoelhgbpcmcmcblflldhk/main.js (6)\n[18613:18613:0317/005924.936957:496786722:INFO:CONSOLE(34)] \"navigate-guest command\", source: chrome-extension://fmgpgbkijfkhoelhgbpcmcmcblflldhk/main.js (34)\n[18613:18613:0317/005925.054967:496904737:INFO:CONSOLE(6)] \"onAppCommand: navigate-guest\", source: chrome-extension://fmgpgbkijfkhoelhgbpcmcmcblflldhk/main.js (6)\n[18613:18613:0317/005925.055135:496904896:INFO:CONSOLE(34)] \"navigate-guest command\", source: chrome-extension://fmgpgbkijfkhoelhgbpcmcmcblflldhk/main.js (34)\n[18613:18613:0317/005925.129293:496979083:INFO:CONSOLE(6)] \"onAppCommand: show-guest\", source: chrome-extension://fmgpgbkijfkhoelhgbpcmcmcblflldhk/main.js (6)\n[18613:18659:0317/005925.717467:497567229:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] WebViewAPITest.DisplayNoneSetSrc (3106 ms)\n[87/202] WebViewAPITest.DisplayNoneSetSrc (3445 ms)\n[ RUN ] AppViewTest.TestAppViewMediaRequest\n\nDevTools listening on ws://127.0.0.1:36536/devtools/browser/5c89ea9f-d517-4efa-bc2a-a598084f8ea9\n[18609:18609:0317/005924.600535:496450313:INFO:CONSOLE(74)] \"appToEmbed pgiodgaahpiagdbhliednffmhidckege\", source: chrome-extension://edgmjfmjpplaibnccnlbgaaakabpghcm/main.js (74)\n[18609:18609:0317/005924.686148:496535922:INFO:CONSOLE(76)] \"Attempting to connect to app.\", source: chrome-extension://edgmjfmjpplaibnccnlbgaaakabpghcm/main.js (76)\n[18609:18609:0317/005925.420068:497269844:INFO:CONSOLE(84)] \"Connected.\", source: chrome-extension://edgmjfmjpplaibnccnlbgaaakabpghcm/main.js (84)\n[ OK ] AppViewTest.TestAppViewMediaRequest (4128 ms)\n[88/202] AppViewTest.TestAppViewMediaRequest (4485 ms)\n[ RUN ] WebViewAPITest.GuestVisibilityChanged\n\nDevTools listening on ws://127.0.0.1:35684/devtools/browser/c8087e9b-f765-4a15-8d81-d3e2795dd47e\n[18929:18929:0317/005928.589409:500439192:INFO:CONSOLE(6)] \"onAppCommand: hide-guest\", source: chrome-extension://njoflokikcjbllkjjimeagdoledhbija/main.js (6)\n[18929:18962:0317/005928.749271:500599049:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewAPITest.GuestVisibilityChanged (2859 ms)\n[89/202] WebViewAPITest.GuestVisibilityChanged (3172 ms)\n[ RUN ] WebViewAPITest.CloseOnLoadcommit\n\nDevTools listening on ws://127.0.0.1:35647/devtools/browser/005b40a2-f524-4103-95fb-a94cf2cdcd89\n[18930:18991:0317/005929.036924:500886685:ERROR:browser_process_sub_thread.cc(217)] Waited 7 ms for network service\n[ OK ] WebViewAPITest.CloseOnLoadcommit (3004 ms)\n[90/202] WebViewAPITest.CloseOnLoadcommit (3436 ms)\n[ RUN ] WebViewAPITest.TestAllowTransparencyAttribute\n\nDevTools listening on ws://127.0.0.1:37292/devtools/browser/28d910cf-de55-46b9-829f-ebda5e1d0be5\n[19077:19148:0317/005929.709783:501559558:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestAllowTransparencyAttribute (2627 ms)\n[91/202] WebViewAPITest.TestAllowTransparencyAttribute (2938 ms)\n[ RUN ] WebViewAPITest.ReloadEmbedder\n\nDevTools listening on ws://127.0.0.1:46659/devtools/browser/d8d62285-b756-4604-b274-c90ee398d4b6\n[18934:18986:0317/005929.987761:501837526:ERROR:browser_process_sub_thread.cc(217)] Waited 8 ms for network service\n[ OK ] WebViewAPITest.ReloadEmbedder (3910 ms)\n[92/202] WebViewAPITest.ReloadEmbedder (4226 ms)\n[ RUN ] WebViewAPITest.TestCustomElementCallbacksInaccessible\n\nDevTools listening on ws://127.0.0.1:43084/devtools/browser/28a206d2-f5b6-4ea7-ae19-2b6de540f206\n[ OK ] WebViewAPITest.TestCustomElementCallbacksInaccessible (2000 ms)\n[93/202] WebViewAPITest.TestCustomElementCallbacksInaccessible (2389 ms)\n[ RUN ] WebViewAPITest.TestAPIMethodExistence\n\nDevTools listening on ws://127.0.0.1:42527/devtools/browser/7cb0ac11-2063-4d72-86e1-5e09bc9a342f\n[19231:19283:0317/005931.965731:503815501:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] WebViewAPITest.TestAPIMethodExistence (2871 ms)\n[94/202] WebViewAPITest.TestAPIMethodExistence (3179 ms)\n[ RUN ] WebViewAPITest.TestAutosizeAfterNavigation\n\nDevTools listening on ws://127.0.0.1:40120/devtools/browser/a85d1cb7-2c72-4d3c-9465-8a6a00b09d32\n[19385:19439:0317/005933.261697:505111476:ERROR:browser_process_sub_thread.cc(217)] Waited 7 ms for network service\n[ OK ] WebViewAPITest.TestAutosizeAfterNavigation (2959 ms)\n[95/202] WebViewAPITest.TestAutosizeAfterNavigation (3181 ms)\n[ RUN ] WebViewAPITest.TestAssignSrcAfterCrash\n\nDevTools listening on ws://127.0.0.1:43375/devtools/browser/97f4d9aa-062f-4e90-8dab-14be7d27a72e\n[19328:19328:0317/005932.859636:504709410:INFO:CONSOLE(293)] \"<webview>: The load has aborted with error -3: ERR_ABORTED.\", source: extensions::webViewEvents (293)\n[19328:19424:0317/005933.353559:505203331:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] WebViewAPITest.TestAssignSrcAfterCrash (3324 ms)\n[96/202] WebViewAPITest.TestAssignSrcAfterCrash (3725 ms)\n[ RUN ] WebViewAPITest.TestAutosizeBeforeNavigation\n\nDevTools listening on ws://127.0.0.1:46163/devtools/browser/9766d27c-4ed4-421b-a3e1-720ba54c224e\n[19553:19575:0317/005934.545629:506395422:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewAPITest.TestAutosizeBeforeNavigation (2683 ms)\n[97/202] WebViewAPITest.TestAutosizeBeforeNavigation (2914 ms)\n[ RUN ] WebViewAPITest.TestAutosizeHeight\n\nDevTools listening on ws://127.0.0.1:45343/devtools/browser/b12e7a7d-a4ad-4eba-a53d-2232e4af0171\n[19566:19654:0317/005935.195114:507044924:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestAutosizeHeight (2943 ms)\n[98/202] WebViewAPITest.TestAutosizeHeight (3176 ms)\n[ RUN ] WebViewAPITest.TestCannotMutateEventName\n\nDevTools listening on ws://127.0.0.1:39357/devtools/browser/f7814c07-9766-4a46-9d4a-54a394fb63c8\n[ OK ] WebViewAPITest.TestCannotMutateEventName (2714 ms)\n[99/202] WebViewAPITest.TestCannotMutateEventName (2914 ms)\n[ RUN ] WebViewAPITest.TestAutosizeRemoveAttributes\n\nDevTools listening on ws://127.0.0.1:33560/devtools/browser/83f920cc-819f-4680-abf1-a5252d74afd2\n[ OK ] WebViewAPITest.TestAutosizeRemoveAttributes (3188 ms)\n[100/202] WebViewAPITest.TestAutosizeRemoveAttributes (3439 ms)\n[ RUN ] WebViewAPITest.TestChromeExtensionRelativePath\n\nDevTools listening on ws://127.0.0.1:35029/devtools/browser/fdd62916-7ba9-483b-ae25-c8203f9f450e\n[19881:19881:0317/005937.219171:509068947:INFO:CONSOLE(14)] \"guest_with_inline_script.html: Inline script ran\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/guest_with_inline_script.html (14)\n[ OK ] WebViewAPITest.TestChromeExtensionRelativePath (2666 ms)\n[101/202] WebViewAPITest.TestChromeExtensionRelativePath (2920 ms)\n[ RUN ] WebViewAPITest.TestChromeExtensionURL\n\nDevTools listening on ws://127.0.0.1:36098/devtools/browser/c0ad6e49-aa5f-4bd7-9b53-ce04a233f367\n[19921:19921:0317/005938.078586:509928363:INFO:CONSOLE(14)] \"guest_with_inline_script.html: Inline script ran\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/guest_with_inline_script.html (14)\n[ OK ] WebViewAPITest.TestChromeExtensionURL (2712 ms)\n[102/202] WebViewAPITest.TestChromeExtensionURL (3193 ms)\n[ RUN ] WebViewAPITest.TestContentLoadEvent\n\nDevTools listening on ws://127.0.0.1:42897/devtools/browser/e490af18-78b2-47c1-86bb-49a7da2bdba4\n[20050:20088:0317/005939.595462:511445238:ERROR:browser_process_sub_thread.cc(217)] Waited 8 ms for network service\n[ OK ] WebViewAPITest.TestContentLoadEvent (2982 ms)\n[103/202] WebViewAPITest.TestContentLoadEvent (3187 ms)\n[ RUN ] WebViewAPITest.TestContextMenu\n\nDevTools listening on ws://127.0.0.1:40442/devtools/browser/2cd84917-6b5c-491b-985c-5f8a97fd02d3\n[20063:20108:0317/005939.725147:511574908:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] WebViewAPITest.TestContextMenu (2796 ms)\n[104/202] WebViewAPITest.TestContextMenu (3176 ms)\n[ RUN ] WebViewAPITest.TestDeclarativeWebRequestAPI\n\nDevTools listening on ws://127.0.0.1:43022/devtools/browser/e149d5d4-f813-4e1e-a118-45297f47b0bf\n[20154:20154:0317/005940.158609:512008384:INFO:CONSOLE(293)] \"<webview>: The load has aborted with error -20: ERR_BLOCKED_BY_CLIENT.\", source: extensions::webViewEvents (293)\n[20243:20243:0317/005940.242665:512092444:WARNING:ipc_message_attachment_set.cc(49)] MessageAttachmentSet destroyed with unconsumed attachments: 0/1\n[20243:20243:0317/005940.243575:512093347:WARNING:ipc_message_attachment_set.cc(49)] MessageAttachmentSet destroyed with unconsumed attachments: 0/1\n[20154:20228:0317/005940.320904:512170682:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewAPITest.TestDeclarativeWebRequestAPI (2577 ms)\n[105/202] WebViewAPITest.TestDeclarativeWebRequestAPI (2956 ms)\n[ RUN ] WebViewAPITest.TestDeclarativeWebRequestAPISendMessage\n\nDevTools listening on ws://127.0.0.1:45165/devtools/browser/1ea90d88-fd5e-4895-bdb2-d1087ef0189b\n[20263:20263:0317/005940.678091:512527889:INFO:CONSOLE(576)] \"http://localhost:46525/empty_guest.html\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (576)\n[20263:20296:0317/005941.083017:512932788:ERROR:service_manager_context.cc(242)] Attempting to run unsupported native service: /b/s/w/ir/out/Release/content_browser.service\n[20263:20296:0317/005941.084770:512934556:ERROR:service_manager_context.cc(242)] Attempting to run unsupported native service: /b/s/w/ir/out/Release/content_browser.service\n[20263:20296:0317/005941.086015:512935782:ERROR:service_manager_context.cc(242)] Attempting to run unsupported native service: /b/s/w/ir/out/Release/content_browser.service\n[20263:20296:0317/005941.087040:512936804:ERROR:service_manager_context.cc(242)] Attempting to run unsupported native service: /b/s/w/ir/out/Release/content_browser.service\n[20263:20296:0317/005941.088046:512937811:ERROR:service_manager_context.cc(242)] Attempting to run unsupported native service: /b/s/w/ir/out/Release/content_browser.service\n[20263:20296:0317/005941.090853:512940626:ERROR:service_manager_context.cc(242)] Attempting to run unsupported native service: /b/s/w/ir/out/Release/content_browser.service\n[20263:20296:0317/005941.092363:512942137:ERROR:service_manager_context.cc(242)] Attempting to run unsupported native service: /b/s/w/ir/out/Release/content_browser.service\n[20263:20296:0317/005941.097282:512947052:ERROR:service_manager_context.cc(242)] Attempting to run unsupported native service: /b/s/w/ir/out/Release/content_browser.service\n[ OK ] WebViewAPITest.TestDeclarativeWebRequestAPISendMessage (2467 ms)\n[106/202] WebViewAPITest.TestDeclarativeWebRequestAPISendMessage (2681 ms)\n[ RUN ] WebViewAPITest.TestDestroyOnEventListener\n\nDevTools listening on ws://127.0.0.1:32970/devtools/browser/451390cf-f7cb-4b57-9c60-999ba936e4c0\n[20379:20379:0317/005942.611400:514461171:INFO:CONSOLE(625)] \"loadcommit1\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (625)\n[20379:20379:0317/005942.651296:514501068:INFO:CONSOLE(630)] \"loadcommit2\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (630)\n[ OK ] WebViewAPITest.TestDestroyOnEventListener (3008 ms)\n[107/202] WebViewAPITest.TestDestroyOnEventListener (3444 ms)\n[ RUN ] WebViewAPITest.TestDialogAlert\n\nDevTools listening on ws://127.0.0.1:38721/devtools/browser/d7bf5c67-abbd-4789-bd5e-57d48e4b8e28\n[20386:20386:0317/005942.649718:514499483:INFO:CONSOLE(77)] \"webview has loaded.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (77)\n[20386:20386:0317/005942.860914:514710709:INFO:CONSOLE(81)] \"Script has been injected into webview.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (81)\n[20386:20386:0317/005942.882424:514732192:INFO:CONSOLE(92)] \"A communication channel has been established with webview.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (92)\n[20386:20386:0317/005942.883350:514733115:INFO:CONSOLE(113)] \"The alert dialog test has started.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (113)\n[20386:20386:0317/005942.902753:514752526:INFO:CONSOLE(128)] \"webview has requested a dialog.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (128)\n[20386:20386:0317/005942.906528:514756299:INFO:CONSOLE(132)] \"The app has responded to the dialog request.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (132)\n[20386:20386:0317/005942.910665:514760434:INFO:CONSOLE(120)] \"webview has been unblocked after requesting an alert dialog.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (120)\n[20386:20438:0317/005943.026482:514876250:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestDialogAlert (2938 ms)\n[108/202] WebViewAPITest.TestDialogAlert (3188 ms)\n[ RUN ] WebViewAPITest.TestDialogConfirm\n\nDevTools listening on ws://127.0.0.1:35691/devtools/browser/bb90f6b7-13cc-4083-98bc-b5892677f8e5\n[20455:20455:0317/005943.131510:514981291:INFO:CONSOLE(77)] \"webview has loaded.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (77)\n[20455:20455:0317/005943.340241:515190002:INFO:CONSOLE(81)] \"Script has been injected into webview.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (81)\n[20455:20455:0317/005943.355674:515205435:INFO:CONSOLE(92)] \"A communication channel has been established with webview.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (92)\n[20455:20455:0317/005943.356299:515206055:INFO:CONSOLE(143)] \"The confirm dialog test has started.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (143)\n[20455:20455:0317/005943.371398:515221180:INFO:CONSOLE(158)] \"webview has requested a dialog.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (158)\n[20455:20455:0317/005943.375519:515225290:INFO:CONSOLE(162)] \"The app has responded to the dialog request.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (162)\n[20455:20455:0317/005943.378625:515228396:INFO:CONSOLE(150)] \"webview has reported a result for its confirm dialog.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (150)\n[20455:20549:0317/005943.493012:515342795:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewAPITest.TestDialogConfirm (2789 ms)\n[109/202] WebViewAPITest.TestDialogConfirm (3210 ms)\n[ RUN ] WebViewAPITest.TestDialogConfirmCancel\n\nDevTools listening on ws://127.0.0.1:40811/devtools/browser/5769b7ed-75ae-4a4f-a851-3e9a5426fe49\n[20576:20576:0317/005943.758831:515608610:INFO:CONSOLE(77)] \"webview has loaded.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (77)\n[20576:20576:0317/005943.992947:515842738:INFO:CONSOLE(81)] \"Script has been injected into webview.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (81)\n[20576:20576:0317/005944.030766:515880555:INFO:CONSOLE(92)] \"A communication channel has been established with webview.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (92)\n[20576:20576:0317/005944.033700:515883469:INFO:CONSOLE(173)] \"The confirm dialog test has started.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (173)\n[20576:20576:0317/005944.075285:515925056:INFO:CONSOLE(188)] \"webview has requested a dialog.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (188)\n[20576:20576:0317/005944.085716:515935489:INFO:CONSOLE(192)] \"The app has responded to the dialog request.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (192)\n[20576:20576:0317/005944.089224:515938996:INFO:CONSOLE(180)] \"webview has reported a result for its confirm dialog.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (180)\n[ OK ] WebViewAPITest.TestDialogConfirmCancel (2908 ms)\n[110/202] WebViewAPITest.TestDialogConfirmCancel (3191 ms)\n[ RUN ] WebViewAPITest.TestDialogConfirmDefaultCancel\n\nDevTools listening on ws://127.0.0.1:37007/devtools/browser/08cae697-1335-4eee-a789-b7190e10dbb8\n[20758:20758:0317/005946.025669:517875432:INFO:CONSOLE(77)] \"webview has loaded.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (77)\n[20758:20758:0317/005946.218301:518068071:INFO:CONSOLE(81)] \"Script has been injected into webview.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (81)\n[20758:20758:0317/005946.237255:518087035:INFO:CONSOLE(92)] \"A communication channel has been established with webview.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (92)\n[20758:20758:0317/005946.238304:518088075:INFO:CONSOLE(203)] \"The confirm dialog test has started.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (203)\n[20758:20758:0317/005946.253481:518103251:INFO:CONSOLE(218)] \"webview has requested a dialog.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (218)\n[20758:20758:0317/005946.264309:518114081:INFO:CONSOLE(164)] \"<webview>: A confirm dialog was blocked.\", source: extensions::webViewActionRequests (164)\n[20758:20758:0317/005946.265525:518115293:INFO:CONSOLE(210)] \"webview has reported a result for its confirm dialog.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (210)\n[20758:20802:0317/005946.380714:518230480:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewAPITest.TestDialogConfirmDefaultCancel (3140 ms)\n[111/202] WebViewAPITest.TestDialogConfirmDefaultCancel (3440 ms)\n[ RUN ] WebViewAPITest.TestDialogConfirmDefaultGCCancel\n\nDevTools listening on ws://127.0.0.1:44246/devtools/browser/e55661b1-6b01-4b31-a374-80c2a7240d76\n[20759:20759:0317/005946.054432:517904210:INFO:CONSOLE(77)] \"webview has loaded.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (77)\n[20759:20759:0317/005946.250876:518100650:INFO:CONSOLE(81)] \"Script has been injected into webview.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (81)\n[20759:20759:0317/005946.271104:518120881:INFO:CONSOLE(92)] \"A communication channel has been established with webview.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (92)\n[20759:20759:0317/005946.271312:518121076:INFO:CONSOLE(231)] \"The confirm dialog test has started.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (231)\n[20759:20759:0317/005946.290699:518140471:INFO:CONSOLE(246)] \"webview has requested a dialog.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (246)\n[20759:20759:0317/005946.379277:518229049:INFO:CONSOLE(164)] \"<webview>: A confirm dialog was blocked.\", source: extensions::webViewActionRequests (164)\n[20759:20759:0317/005946.381026:518230794:INFO:CONSOLE(238)] \"webview has reported a result for its confirm dialog.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (238)\n[ OK ] WebViewAPITest.TestDialogConfirmDefaultGCCancel (3254 ms)\n[112/202] WebViewAPITest.TestDialogConfirmDefaultGCCancel (3442 ms)\n[ RUN ] WebViewAPITest.TestDialogPrompt\n\nDevTools listening on ws://127.0.0.1:41447/devtools/browser/fd09d1ce-a708-4f50-a5ef-f8e4057567de\n[20818:20818:0317/005946.524022:518373797:INFO:CONSOLE(77)] \"webview has loaded.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (77)\n[20818:20818:0317/005946.736415:518586190:INFO:CONSOLE(81)] \"Script has been injected into webview.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (81)\n[20818:20818:0317/005946.753462:518603235:INFO:CONSOLE(92)] \"A communication channel has been established with webview.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (92)\n[20818:20818:0317/005946.754639:518604410:INFO:CONSOLE(264)] \"The prompt dialog test has started.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (264)\n[20818:20818:0317/005946.775796:518625558:INFO:CONSOLE(279)] \"webview has requested a dialog.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (279)\n[20818:20818:0317/005946.779360:518629129:INFO:CONSOLE(284)] \"The app has responded to the dialog request.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (284)\n[20818:20818:0317/005946.783115:518632884:INFO:CONSOLE(271)] \"webview has reported a result for its prompt dialog.\", source: chrome-extension://cfociaogdekheojfbgljemgknfbolfic/embedder.js (271)\n[20818:20946:0317/005946.921597:518771359:ERROR:browser_process_sub_thread.cc(217)] Waited 14 ms for network service\n[ OK ] WebViewAPITest.TestDialogPrompt (3045 ms)\n[113/202] WebViewAPITest.TestDialogPrompt (3437 ms)\n[ RUN ] WebViewAPITest.TestDisplayNoneWebviewLoad\n\nDevTools listening on ws://127.0.0.1:43713/devtools/browser/8b7c1bee-987a-4cf3-ade3-a6c5c4499c6d\n[20956:21010:0317/005947.060035:518909797:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewAPITest.TestDisplayNoneWebviewLoad (2529 ms)\n[114/202] WebViewAPITest.TestDisplayNoneWebviewLoad (2915 ms)\n[ RUN ] WebViewAPITest.TestEventName\n\nDevTools listening on ws://127.0.0.1:39827/devtools/browser/592e2bd6-d833-4217-b93d-2ccc4a39d0d2\n[21139:21188:0317/005949.549701:521399474:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestEventName (2873 ms)\n[115/202] WebViewAPITest.TestEventName (3177 ms)\n[ RUN ] WebViewAPITest.TestExecuteScriptFail\n\nDevTools listening on ws://127.0.0.1:35247/devtools/browser/71d0f042-7fc9-4b17-b0ad-02e074e20ffd\n[21179:21179:0317/005949.665145:521514910:INFO:CONSOLE(196)] \"<webview>: Script cannot be injected into content until the page has loaded.\", source: extensions::webView (196)\n[ OK ] WebViewAPITest.TestExecuteScriptFail (2453 ms)\n[116/202] WebViewAPITest.TestExecuteScriptFail (2657 ms)\n[ RUN ] WebViewAPITest.TestExecuteScript\n\nDevTools listening on ws://127.0.0.1:38699/devtools/browser/0f8dc4bf-81e8-42ca-97f0-28751e852c1a\n[21140:21189:0317/005949.953940:521803705:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestExecuteScript (3246 ms)\n[117/202] WebViewAPITest.TestExecuteScript (3441 ms)\n[ RUN ] WebViewAPITest.TestFindAPI\n\nDevTools listening on ws://127.0.0.1:42241/devtools/browser/579f463a-3472-4eac-a828-e89f4a6a4b05\n[ OK ] WebViewAPITest.TestFindAPI (3154 ms)\n[118/202] WebViewAPITest.TestFindAPI (3460 ms)\n[ RUN ] WebViewAPITest.TestGetProcessId\n\nDevTools listening on ws://127.0.0.1:39537/devtools/browser/0d114fbd-7dc2-4d26-994e-5ea6ae8e7a63\n[ OK ] WebViewAPITest.TestGetProcessId (3078 ms)\n[119/202] WebViewAPITest.TestGetProcessId (3447 ms)\n[ RUN ] WebViewAPITest.TestHiddenBeforeNavigation\n\nDevTools listening on ws://127.0.0.1:41047/devtools/browser/146d7e82-da6f-4f56-bd19-40f86634bc89\n[21469:21469:0317/005952.859362:524709140:INFO:CONSOLE(941)] \"webview.loadstop\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (941)\n[21469:21469:0317/005953.071883:524921652:INFO:CONSOLE(956)] \"script injection success\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (956)\n[21469:21504:0317/005953.190556:525040324:ERROR:browser_process_sub_thread.cc(217)] Waited 6 ms for network service\n[ OK ] WebViewAPITest.TestHiddenBeforeNavigation (3031 ms)\n[120/202] WebViewAPITest.TestHiddenBeforeNavigation (3435 ms)\n[ RUN ] WebViewAPITest.TestInlineScriptFromAccessibleResources\n\nDevTools listening on ws://127.0.0.1:44034/devtools/browser/3b05faeb-0fb6-4d9f-8261-aae341c3dae7\n[21548:21548:0317/005953.502348:525352118:INFO:CONSOLE(14)] \"guest_with_inline_script.html: Inline script ran\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/guest_with_inline_script.html (14)\n[21548:21548:0317/005953.514756:525364528:INFO:CONSOLE(976)] \"consolemessage: guest_with_inline_script.html: Inline script ran\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (976)\n[21548:21672:0317/005953.631386:525481148:ERROR:browser_process_sub_thread.cc(217)] Waited 7 ms for network service\n[ OK ] WebViewAPITest.TestInlineScriptFromAccessibleResources (2510 ms)\n[121/202] WebViewAPITest.TestInlineScriptFromAccessibleResources (2945 ms)\n[ RUN ] WebViewAPITest.TestFindAPI_findupdate\n\nDevTools listening on ws://127.0.0.1:44020/devtools/browser/6a178266-7f12-4aa2-8e8e-8715a1926c37\n[21445:21499:0317/005953.565960:525415720:ERROR:browser_process_sub_thread.cc(217)] Waited 6 ms for network service\n[ OK ] WebViewAPITest.TestFindAPI_findupdate (3679 ms)\n[122/202] WebViewAPITest.TestFindAPI_findupdate (3968 ms)\n[ RUN ] WebViewAPITest.TestInvalidChromeExtensionURL\n\nDevTools listening on ws://127.0.0.1:34183/devtools/browser/c06b5596-c87f-4f7c-9d1d-0122d706843f\n[ OK ] WebViewAPITest.TestInvalidChromeExtensionURL (2915 ms)\n[123/202] WebViewAPITest.TestInvalidChromeExtensionURL (3175 ms)\n[ RUN ] WebViewAPITest.TestLoadAbortEmptyResponse\n\nDevTools listening on ws://127.0.0.1:36740/devtools/browser/e64fa0c0-485e-4444-80de-ad1de2942012\n[21840:21909:0317/005956.650567:528500335:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[1:1:0317/005956.658492:528508411:ERROR:command_buffer_proxy_impl.cc(106)] ContextResult::kTransientFailure: Shared memory region is not valid\n[ OK ] WebViewAPITest.TestLoadAbortEmptyResponse (2844 ms)\n[124/202] WebViewAPITest.TestLoadAbortEmptyResponse (3183 ms)\n[ RUN ] WebViewAPITest.TestLoadAbortIllegalChromeURL\n\nDevTools listening on ws://127.0.0.1:34944/devtools/browser/8042a11b-59ac-422e-a031-6b5ca55b1d1d\n[21841:21841:0317/005956.283109:528132882:INFO:CONSOLE(293)] \"<webview>: The load has aborted with error -301: ERR_DISALLOWED_URL_SCHEME.\", source: extensions::webViewEvents (293)\n[21841:21899:0317/005956.733328:528583090:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] WebViewAPITest.TestLoadAbortIllegalChromeURL (2881 ms)\n[125/202] WebViewAPITest.TestLoadAbortIllegalChromeURL (3213 ms)\n[ RUN ] WebViewAPITest.TestLoadAbortChromeExtensionURLWrongPartition\n[21821:21821:0317/005954.667857:526517652:ERROR:device_event_log_impl.cc(159)] [00:59:54.665] Network: device_event_log.cc:122 @@@ Slow method: ../../chromeos/network/network_state_handler.cc:NotifyDeviceListChanged: 69ms\n\nDevTools listening on ws://127.0.0.1:43177/devtools/browser/c1f4f699-d2b6-4109-aae3-629aeac84320\n[21966:21966:0317/005956.679812:528529587:WARNING:ipc_message_attachment_set.cc(49)] MessageAttachmentSet destroyed with unconsumed attachments: 0/1\n[21966:21966:0317/005956.680082:528529846:WARNING:ipc_message_attachment_set.cc(49)] MessageAttachmentSet destroyed with unconsumed attachments: 0/1\n[21821:21903:0317/005956.730087:528579847:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] WebViewAPITest.TestLoadAbortChromeExtensionURLWrongPartition (3122 ms)\n[126/202] WebViewAPITest.TestLoadAbortChromeExtensionURLWrongPartition (3448 ms)\n[ RUN ] WebViewAPITest.TestLoadAbortIllegalFileURL\n\nDevTools listening on ws://127.0.0.1:36180/devtools/browser/aa58b5ad-ea69-4a08-853f-ae7512752705\n[22133:22133:0317/005958.889077:530738852:INFO:CONSOLE(293)] \"<webview>: The load has aborted with error -301: ERR_DISALLOWED_URL_SCHEME.\", source: extensions::webViewEvents (293)\n[22133:22183:0317/005959.251034:531100794:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestLoadAbortIllegalFileURL (2633 ms)\n[127/202] WebViewAPITest.TestLoadAbortIllegalFileURL (2922 ms)\n[ RUN ] WebViewAPITest.TestLoadAbortIllegalJavaScriptURL\n\nDevTools listening on ws://127.0.0.1:33716/devtools/browser/449c6b0d-ebb7-4a90-937a-72cd3108dd05\n[22171:22171:0317/005959.567194:531416966:INFO:CONSOLE(293)] \"<webview>: The load has aborted with error -301: ERR_DISALLOWED_URL_SCHEME.\", source: extensions::webViewEvents (293)\n[ OK ] WebViewAPITest.TestLoadAbortIllegalJavaScriptURL (2904 ms)\n[128/202] WebViewAPITest.TestLoadAbortIllegalJavaScriptURL (3175 ms)\n[ RUN ] WebViewAPITest.TestLoadAbortInvalidNavigation\n\nDevTools listening on ws://127.0.0.1:36496/devtools/browser/00333824-f39c-417f-a24e-0b4a9b43bfdd\n[22178:22178:0317/005959.588084:531437860:INFO:CONSOLE(293)] \"<webview>: The load has aborted with error -300: ERR_INVALID_URL.\", source: extensions::webViewEvents (293)\n[22178:22269:0317/005959.979597:531829372:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewAPITest.TestLoadAbortInvalidNavigation (2914 ms)\n[129/202] WebViewAPITest.TestLoadAbortInvalidNavigation (3204 ms)\n[ RUN ] WebViewAPITest.TestLoadAbortNonWebSafeScheme\n\nDevTools listening on ws://127.0.0.1:37903/devtools/browser/e790de73-a912-4a9b-9e5a-d371c53d6bfa\n[22173:22173:0317/005959.731025:531580805:INFO:CONSOLE(293)] \"<webview>: The load has aborted with error -301: ERR_DISALLOWED_URL_SCHEME.\", source: extensions::webViewEvents (293)\n[ OK ] WebViewAPITest.TestLoadAbortNonWebSafeScheme (3110 ms)\n[130/202] WebViewAPITest.TestLoadAbortNonWebSafeScheme (3441 ms)\n[ RUN ] WebViewAPITest.TestLoadAbortUnknownScheme\n\nDevTools listening on ws://127.0.0.1:39072/devtools/browser/7391db29-7127-4c2c-b3b9-6ab536aa6e4a\n[22465:22465:0317/010001.883121:533732989:INFO:CONSOLE(293)] \"<webview>: The load has aborted with error -302: ERR_UNKNOWN_URL_SCHEME.\", source: extensions::webViewEvents (293)\n[22465:22520:0317/010002.084390:533934159:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestLoadAbortUnknownScheme (2571 ms)\n[131/202] WebViewAPITest.TestLoadAbortUnknownScheme (2911 ms)\n[ RUN ] WebViewAPITest.TestLoadProgressEvent\n\nDevTools listening on ws://127.0.0.1:35323/devtools/browser/ec4075f7-51cb-4a99-ab62-064824591c5c\n[ OK ] WebViewAPITest.TestLoadProgressEvent (3235 ms)\n[132/202] WebViewAPITest.TestLoadProgressEvent (3449 ms)\n[ RUN ] WebViewAPITest.TestLoadStartLoadRedirect\n\nDevTools listening on ws://127.0.0.1:40781/devtools/browser/a2f03a54-7621-4244-bc51-4912d66176a1\n[22591:22643:0317/010003.203743:535053516:ERROR:service_manager_context.cc(242)] Attempting to run unsupported native service: /b/s/w/ir/out/Release/content_browser.service\n[22591:22643:0317/010003.251043:535100816:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestLoadStartLoadRedirect (2811 ms)\n[133/202] WebViewAPITest.TestLoadStartLoadRedirect (3184 ms)\n[ RUN ] WebViewAPITest.TestCanGoBack\n\nDevTools listening on ws://127.0.0.1:43752/devtools/browser/b5725ce2-f7a3-41a3-a80b-449649e49490\n[22549:22549:0317/010003.264559:535114338:INFO:CONSOLE(293)] \"<webview>: The load has aborted with error -11: ERR_NOT_IMPLEMENTED.\", source: extensions::webViewEvents (293)\n[22549:22616:0317/010003.426900:535276661:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewAPITest.TestCanGoBack (3152 ms)\n[134/202] WebViewAPITest.TestCanGoBack (3452 ms)\n[ RUN ] WebViewAPITest.TestNavigateAfterResize\n\nDevTools listening on ws://127.0.0.1:34706/devtools/browser/382f6e40-e35c-433b-9a37-9ced865641d3\n[ OK ] WebViewAPITest.TestNavigateAfterResize (2791 ms)\n[135/202] WebViewAPITest.TestNavigateAfterResize (3183 ms)\n[ RUN ] WebViewAPITest.TestContentInitiatedNavigationToDataUrlBlocked\n\nDevTools listening on ws://127.0.0.1:43261/devtools/browser/b03029b3-7d1c-4bfa-930e-93ffb5e5421d\n[22912:22912:0317/010006.579527:538429303:INFO:CONSOLE(0)] \"Not allowed to navigate top frame to data URL: data:text/html,foo\", source: data:text/html,<script>window.location.href = \"data:text/html,foo\";</script> (0)\n[ OK ] WebViewAPITest.TestContentInitiatedNavigationToDataUrlBlocked (3080 ms)\n[136/202] WebViewAPITest.TestContentInitiatedNavigationToDataUrlBlocked (3436 ms)\n[ RUN ] WebViewAPITest.TestNavOnConsecutiveSrcAttributeChanges\n\nDevTools listening on ws://127.0.0.1:34501/devtools/browser/90a866df-37b1-46a3-a19c-fe4e02915ed1\n[22913:22944:0317/010006.801720:538651490:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestNavOnConsecutiveSrcAttributeChanges (3139 ms)\n[137/202] WebViewAPITest.TestNavOnConsecutiveSrcAttributeChanges (3439 ms)\n[ RUN ] WebViewAPITest.TestNavOnSrcAttributeChange\n\nDevTools listening on ws://127.0.0.1:36777/devtools/browser/7c28e908-41be-47b1-b3dd-ede190866169\n[22914:22953:0317/010006.782286:538632054:ERROR:browser_process_sub_thread.cc(217)] Waited 0 ms for network service\n[ OK ] WebViewAPITest.TestNavOnSrcAttributeChange (3085 ms)\n[138/202] WebViewAPITest.TestNavOnSrcAttributeChange (3437 ms)\n[ RUN ] WebViewAPITest.TestNewWindow\n\nDevTools listening on ws://127.0.0.1:42758/devtools/browser/17d26662-2238-45ab-8f94-4461bfefce7b\n[23115:23128:0317/010008.772320:540622104:ERROR:browser_process_sub_thread.cc(217)] Waited 2 ms for network service\n[ OK ] WebViewAPITest.TestNewWindow (3152 ms)\n[139/202] WebViewAPITest.TestNewWindow (3449 ms)\n[ RUN ] WebViewAPITest.TestNewWindowNoReferrerLink\n\nDevTools listening on ws://127.0.0.1:43243/devtools/browser/ab128d36-8ee1-4231-ad51-661812cef89a\n[23239:23275:0317/010010.506021:542355789:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewAPITest.TestNewWindowNoReferrerLink (3404 ms)\n[140/202] WebViewAPITest.TestNewWindowNoReferrerLink (3696 ms)\n[ RUN ] WebViewAPITest.TestNewWindowTwoListeners\n\nDevTools listening on ws://127.0.0.1:37810/devtools/browser/43c38793-03b6-4c8c-b4ec-a15a0bc05c43\n[23240:23281:0317/010010.504207:542353976:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewAPITest.TestNewWindowTwoListeners (3353 ms)\n[141/202] WebViewAPITest.TestNewWindowTwoListeners (3699 ms)\n[ RUN ] WebViewAPITest.TestNewWindowNoPreventDefault\n\nDevTools listening on ws://127.0.0.1:40234/devtools/browser/9a16089f-dd3b-4601-9c98-c88c7c032c4d\n[ OK ] WebViewAPITest.TestNewWindowNoPreventDefault (3566 ms)\n[142/202] WebViewAPITest.TestNewWindowNoPreventDefault (3968 ms)\n[ RUN ] WebViewAPITest.TestOnEventProperty\n\nDevTools listening on ws://127.0.0.1:42960/devtools/browser/989cae7d-9fc4-4ce9-9ba2-2781280da4e7\n[ OK ] WebViewAPITest.TestOnEventProperty (2907 ms)\n[143/202] WebViewAPITest.TestOnEventProperty (3182 ms)\n[ RUN ] WebViewAPITest.TestPartitionChangeAfterNavigation\n\nDevTools listening on ws://127.0.0.1:45417/devtools/browser/a0dbf89e-7cb1-4a57-a6aa-205722d7fa37\n[23575:23575:0317/010013.605667:545455444:INFO:CONSOLE(157)] \"<webview>: The object has already navigated, so its partition cannot be changed.\", source: extensions::webViewAttributes (157)\n[23575:23620:0317/010013.825247:545675019:ERROR:browser_process_sub_thread.cc(217)] Waited 6 ms for network service\n[ OK ] WebViewAPITest.TestPartitionChangeAfterNavigation (3023 ms)\n[144/202] WebViewAPITest.TestPartitionChangeAfterNavigation (3440 ms)\n[ RUN ] WebViewAPITest.TestPartitionRemovalAfterNavigationFails\n\nDevTools listening on ws://127.0.0.1:38067/devtools/browser/949ee5d0-00cd-487d-8233-7fbbaafeb94a\n[23576:23576:0317/010013.803366:545653140:INFO:CONSOLE(157)] \"<webview>: The object has already navigated, so its partition cannot be changed.\", source: extensions::webViewAttributes (157)\n[23576:23624:0317/010013.965754:545815514:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestPartitionRemovalAfterNavigationFails (3132 ms)\n[145/202] WebViewAPITest.TestPartitionRemovalAfterNavigationFails (3438 ms)\n[ RUN ] WebViewAPITest.TestReassignSrcAttribute\n\nDevTools listening on ws://127.0.0.1:42197/devtools/browser/d3deac81-79e2-4e5a-a7f7-df7ae17a5ccb\n[23581:23581:0317/010013.690157:545539930:INFO:CONSOLE(1476)] \"[1] loadstop called\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (1476)\n[23581:23581:0317/010013.736086:545585868:INFO:CONSOLE(293)] \"<webview>: The load has aborted with error -3: ERR_ABORTED.\", source: extensions::webViewEvents (293)\n[23581:23581:0317/010013.819015:545668786:INFO:CONSOLE(1476)] \"[2] loadstop called\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (1476)\n[23581:23581:0317/010014.004775:545854545:INFO:CONSOLE(1476)] \"[3] loadstop called\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (1476)\n[23581:23628:0317/010014.131549:545981327:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] WebViewAPITest.TestReassignSrcAttribute (3101 ms)\n[146/202] WebViewAPITest.TestReassignSrcAttribute (3437 ms)\n[ RUN ] WebViewAPITest.TestRemoveWebviewOnExit\n\nDevTools listening on ws://127.0.0.1:39997/devtools/browser/2ebe0fe3-0b8f-4306-add8-87da9e0ffb65\n[23812:23825:0317/010014.750675:546600440:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestRemoveWebviewOnExit (2519 ms)\n[147/202] WebViewAPITest.TestRemoveWebviewOnExit (2920 ms)\n[ RUN ] WebViewAPITest.TestRemoveSrcAttribute\n\nDevTools listening on ws://127.0.0.1:42238/devtools/browser/46e8c71e-f028-4824-8441-e819c6bdca39\n[23948:24017:0317/010017.220266:549070056:ERROR:browser_process_sub_thread.cc(217)] Waited 4 ms for network service\n[ OK ] WebViewAPITest.TestRemoveSrcAttribute (2723 ms)\n[148/202] WebViewAPITest.TestRemoveSrcAttribute (2922 ms)\n[ RUN ] WebViewAPITest.TestReload\n\nDevTools listening on ws://127.0.0.1:43665/devtools/browser/b420a737-3821-47aa-8239-68280fe12354\n[23935:23982:0317/010017.222186:549071954:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestReload (2977 ms)\n[149/202] WebViewAPITest.TestReload (3190 ms)\n[ RUN ] WebViewAPITest.TestReloadAfterTerminate\n\nDevTools listening on ws://127.0.0.1:38444/devtools/browser/bd6d5a6e-8bbc-4089-9ddb-8ffa8b79d34c\n[ OK ] WebViewAPITest.TestReloadAfterTerminate (3282 ms)\n[150/202] WebViewAPITest.TestReloadAfterTerminate (3444 ms)\n[ RUN ] WebViewAPITest.TestRemoveWebviewAfterNavigation\n\nDevTools listening on ws://127.0.0.1:36327/devtools/browser/5933a429-058b-4c2c-8fd1-68a966e7fa14\n[24045:24153:0317/010017.589392:549439163:ERROR:browser_process_sub_thread.cc(217)] Waited 8 ms for network service\n[ OK ] WebViewAPITest.TestRemoveWebviewAfterNavigation (2294 ms)\n[151/202] WebViewAPITest.TestRemoveWebviewAfterNavigation (2711 ms)\n[ RUN ] WebViewAPITest.TestWebRequestAPI\n\nDevTools listening on ws://127.0.0.1:40263/devtools/browser/6533f71a-c2f2-46cb-8847-2d8e9c1574af\n[24287:24351:0317/010020.411431:552261202:ERROR:service_manager_context.cc(242)] Attempting to run unsupported native service: /b/s/w/ir/out/Release/content_browser.service\n[24287:24351:0317/010020.442535:552292308:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewAPITest.TestWebRequestAPI (2724 ms)\n[152/202] WebViewAPITest.TestWebRequestAPI (3183 ms)\n[ RUN ] WebViewAPITest.TestResizeWebviewResizesContent\n\nDevTools listening on ws://127.0.0.1:46476/devtools/browser/997ee1f1-bcdf-46c2-a64d-a7e51a2a5014\n[24259:24259:0317/010020.695601:552545378:INFO:CONSOLE(1611)] \"The resize test has been injected into webview.\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (1611)\n[24259:24259:0317/010020.696953:552546721:INFO:CONSOLE(1617)] \"The guest script for a two-way comm channel has been injected into webview.\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (1617)\n[24259:24259:0317/010020.719339:552569110:INFO:CONSOLE(1628)] \"A communication channel has been established with webview.\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (1628)\n[24259:24259:0317/010020.719538:552569303:INFO:CONSOLE(1629)] \"Resizing <webview> width from 300px to 400px.\", source: chrome-extension://lnfpfpobnbjbeofoboclakehoopaekod/main.js (1629)\n[ OK ] WebViewAPITest.TestResizeWebviewResizesContent (3477 ms)\n[153/202] WebViewAPITest.TestResizeWebviewResizesContent (3705 ms)\n[ RUN ] WebViewAPITest.TestTerminateAfterExit\n\nDevTools listening on ws://127.0.0.1:44551/devtools/browser/2133f225-93e3-4bd6-b3fa-372058913dc1\n[24260:24316:0317/010020.943216:552792994:ERROR:browser_process_sub_thread.cc(217)] Waited 10 ms for network service\n[ OK ] WebViewAPITest.TestTerminateAfterExit (3511 ms)\n[154/202] WebViewAPITest.TestTerminateAfterExit (3705 ms)\n[ RUN ] WebViewAPITest.TestWebRequestAPIWithHeaders\n\nDevTools listening on ws://127.0.0.1:37852/devtools/browser/0b852497-e2b4-4474-adad-8f446c64644e\n[24290:24355:0317/010020.934741:552784514:ERROR:browser_process_sub_thread.cc(217)] Waited 11 ms for network service\n[ OK ] WebViewAPITest.TestWebRequestAPIWithHeaders (3078 ms)\n[155/202] WebViewAPITest.TestWebRequestAPIWithHeaders (3442 ms)\n[ RUN ] WebViewAPITest.TestWebRequestAPIGoogleProperty\n\nDevTools listening on ws://127.0.0.1:32864/devtools/browser/c7e6cc98-cf54-4cab-866c-282a005b50da\n[24639:24699:0317/010023.917515:555767286:ERROR:browser_process_sub_thread.cc(217)] Waited 4 ms for network service\n[ OK ] WebViewAPITest.TestWebRequestAPIGoogleProperty (2627 ms)\n[156/202] WebViewAPITest.TestWebRequestAPIGoogleProperty (2910 ms)\n[ RUN ] WebViewAPITest.TestLoadEventsSameDocumentNavigation\n\nDevTools listening on ws://127.0.0.1:44800/devtools/browser/789429bd-ae2d-43f4-89f0-0cd687cdd40f\n[24631:24659:0317/010024.106478:555956248:ERROR:browser_process_sub_thread.cc(217)] Waited 14 ms for network service\n[ OK ] WebViewAPITest.TestLoadEventsSameDocumentNavigation (3003 ms)\n[157/202] WebViewAPITest.TestLoadEventsSameDocumentNavigation (3185 ms)\n[ RUN ] WebViewAPITest.TestWebRequestAPIExistence\n\nDevTools listening on ws://127.0.0.1:42182/devtools/browser/6f5ebbf4-ad7d-4fee-b704-fbe4d7eeab67\n[24632:24700:0317/010024.227190:556076961:ERROR:browser_process_sub_thread.cc(217)] Waited 8 ms for network service\n[ OK ] WebViewAPITest.TestWebRequestAPIExistence (3092 ms)\n[158/202] WebViewAPITest.TestWebRequestAPIExistence (3434 ms)\n[ RUN ] WebViewAPITest.TestWebRequestAPIWithExtraHeaders\n\nDevTools listening on ws://127.0.0.1:34093/devtools/browser/6765661b-8c0a-4694-9b0f-1f978662037c\n[24607:24663:0317/010024.528261:556378023:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewAPITest.TestWebRequestAPIWithExtraHeaders (3574 ms)\n[159/202] WebViewAPITest.TestWebRequestAPIWithExtraHeaders (3982 ms)\n[ RUN ] WebViewAPITest.TestNoUserCodeSetOnEventProperty\n\nDevTools listening on ws://127.0.0.1:41984/devtools/browser/6837a844-8566-457b-aaf1-ff9de2c8bdc7\n[24980:24980:0317/010027.178546:559028325:INFO:CONSOLE(0)] \"[SUCCESS] testSetOnEventProperty\", source: chrome-extension://hojfjgdpdcooegekhbdnfapnpcddaagl/main.html (0)\n[24980:25044:0317/010027.269186:559118947:ERROR:browser_process_sub_thread.cc(217)] Waited 8 ms for network service\n[ OK ] WebViewAPITest.TestNoUserCodeSetOnEventProperty (2383 ms)\n[160/202] WebViewAPITest.TestNoUserCodeSetOnEventProperty (2656 ms)\n[ RUN ] WebViewAPITest.TestCaptureVisibleRegion\n\nDevTools listening on ws://127.0.0.1:44492/devtools/browser/7ac3cee5-914a-459b-8576-fa6c5c5663f4\n[24955:24955:0317/010027.303705:559153470:INFO:web_contents_capture_client.cc(60)] Screenshot taken\n[24955:25004:0317/010027.568550:559418321:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[1:7:0317/010027.574619:559424533:ERROR:broker_posix.cc(106)] Error sending sync broker message: Broken pipe (32)\n[1:7:0317/010027.575527:559425401:ERROR:cmd_buffer_helper.cc(141)] ContextResult::kFatalFailure: CommandBufferHelper::AllocateRingBuffer() failed\n[ OK ] WebViewAPITest.TestCaptureVisibleRegion (3259 ms)\n[161/202] WebViewAPITest.TestCaptureVisibleRegion (3705 ms)\n[ RUN ] WebViewAPITest.TestNoUserCodeCreate\n\nDevTools listening on ws://127.0.0.1:42131/devtools/browser/6b13a288-3c7a-44e1-ad90-c3ee3cfd6a54\n[24967:24967:0317/010027.653055:559502829:INFO:CONSOLE(0)] \"[SUCCESS] testCreate\", source: chrome-extension://hojfjgdpdcooegekhbdnfapnpcddaagl/main.html (0)\n[24967:25009:0317/010027.799235:559648998:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestNoUserCodeCreate (3206 ms)\n[162/202] WebViewAPITest.TestNoUserCodeCreate (3455 ms)\n[ RUN ] WebViewAPITest.TestWebViewInsideFrame\n\nDevTools listening on ws://127.0.0.1:33773/devtools/browser/97d182c7-d2a7-4b99-badd-d52a6854f53e\n[ OK ] WebViewAPITest.TestWebViewInsideFrame (3617 ms)\n[163/202] WebViewAPITest.TestWebViewInsideFrame (3982 ms)\n[ RUN ] WebViewAPITest.TestNoUserCodeGetSetAttributes\n\nDevTools listening on ws://127.0.0.1:33498/devtools/browser/0a1ba90b-e015-49a5-afc0-6a8edf0876fc\n[25243:25243:0317/010030.059477:561909255:INFO:CONSOLE(0)] \"[SUCCESS] testGetSetAttributes\", source: chrome-extension://hojfjgdpdcooegekhbdnfapnpcddaagl/main.html (0)\n[25243:25323:0317/010030.154510:562004277:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] WebViewAPITest.TestNoUserCodeGetSetAttributes (2594 ms)\n[164/202] WebViewAPITest.TestNoUserCodeGetSetAttributes (2914 ms)\n[ RUN ] WebViewAPITest.TestNoUserCodeBackForward\n\nDevTools listening on ws://127.0.0.1:43620/devtools/browser/32da5ba2-b980-48f3-afb7-bcbd6b6924f0\n[25306:25306:0317/010030.396349:562246125:INFO:CONSOLE(0)] \"[SUCCESS] testBackForward\", source: chrome-extension://hojfjgdpdcooegekhbdnfapnpcddaagl/main.html (0)\n[25306:25386:0317/010030.520858:562370645:ERROR:browser_process_sub_thread.cc(217)] Waited 8 ms for network service\n[ OK ] WebViewAPITest.TestNoUserCodeBackForward (2525 ms)\n[165/202] WebViewAPITest.TestNoUserCodeBackForward (2912 ms)\n[ RUN ] WebViewAPITest.TestNoUserCodeFocus\n\nDevTools listening on ws://127.0.0.1:37326/devtools/browser/356ed724-4079-44c6-80c9-d1627af1cee4\n[25308:25308:0317/010030.754142:562603904:INFO:CONSOLE(0)] \"[SUCCESS] testFocus\", source: chrome-extension://hojfjgdpdcooegekhbdnfapnpcddaagl/main.html (0)\n[ OK ] WebViewAPITest.TestNoUserCodeFocus (2895 ms)\n[166/202] WebViewAPITest.TestNoUserCodeFocus (3178 ms)\n[ RUN ] WebViewAPITest.TestClosedShadowRoot\n\nDevTools listening on ws://127.0.0.1:41308/devtools/browser/4e53bad4-8140-44a3-adaf-139e8224b383\n[ OK ] WebViewAPITest.TestClosedShadowRoot (2804 ms)\n[167/202] WebViewAPITest.TestClosedShadowRoot (3176 ms)\n[ RUN ] WebViewDPIAPITest.TestAutosizeBeforeNavigation\n\nDevTools listening on ws://127.0.0.1:36209/devtools/browser/de7ab26f-28c7-4375-829f-7886cb138357\n[25550:25599:0317/010033.070993:564920763:ERROR:browser_process_sub_thread.cc(217)] Waited 14 ms for network service\n[ OK ] WebViewDPIAPITest.TestAutosizeBeforeNavigation (2602 ms)\n[168/202] WebViewDPIAPITest.TestAutosizeBeforeNavigation (2918 ms)\n[ RUN ] WebViewMediaAccessAPITest.TestAllow\n\nDevTools listening on ws://127.0.0.1:33301/devtools/browser/aab56f99-8be0-42bd-beee-a62b22cd75c1\n[ OK ] WebViewMediaAccessAPITest.TestAllow (2904 ms)\n[169/202] WebViewMediaAccessAPITest.TestAllow (3178 ms)\n[ RUN ] WebViewDPIAPITest.TestAutosizeHeight\n\nDevTools listening on ws://127.0.0.1:42169/devtools/browser/bb164fcb-fa81-43e2-9f66-cb9f6701b873\n[25595:25709:0317/010034.548647:566398418:ERROR:browser_process_sub_thread.cc(217)] Waited 7 ms for network service\n[ OK ] WebViewDPIAPITest.TestAutosizeHeight (3608 ms)\n[170/202] WebViewDPIAPITest.TestAutosizeHeight (3965 ms)\n[ RUN ] WebViewDPIAPITest.TestAutosizeRemoveAttributes\n\nDevTools listening on ws://127.0.0.1:36462/devtools/browser/09cd8ee7-5da4-403d-8b8b-b3f9b618f7d8\n[25655:25735:0317/010034.505118:566354880:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewDPIAPITest.TestAutosizeRemoveAttributes (3271 ms)\n[171/202] WebViewDPIAPITest.TestAutosizeRemoveAttributes (3713 ms)\n[ RUN ] WebViewMediaAccessAPITest.TestAllowAndThenDeny\n\nDevTools listening on ws://127.0.0.1:33887/devtools/browser/30c4ed7d-72c2-4001-96b5-8e48350b0b87\n[25892:25913:0317/010036.140819:567990579:ERROR:browser_process_sub_thread.cc(217)] Waited 7 ms for network service\n[ OK ] WebViewMediaAccessAPITest.TestAllowAndThenDeny (2744 ms)\n[172/202] WebViewMediaAccessAPITest.TestAllowAndThenDeny (3184 ms)\n[ RUN ] WebViewMediaAccessAPITest.TestAllowAsync\n\nDevTools listening on ws://127.0.0.1:40867/devtools/browser/5aa72c48-66cf-4200-876d-6897044a7e56\n[26006:26058:0317/010037.646391:569496151:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewMediaAccessAPITest.TestAllowAsync (3069 ms)\n[173/202] WebViewMediaAccessAPITest.TestAllowAsync (3451 ms)\n[ RUN ] WebViewMediaAccessAPITest.TestAllowTwice\n\nDevTools listening on ws://127.0.0.1:45331/devtools/browser/9bc5c0b0-f6ac-460f-ba63-b5bad12c7a6e\n[26041:26084:0317/010037.772578:569622339:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] WebViewMediaAccessAPITest.TestAllowTwice (2897 ms)\n[174/202] WebViewMediaAccessAPITest.TestAllowTwice (3173 ms)\n[ RUN ] WebViewMediaAccessAPITest.TestCheck\n\nDevTools listening on ws://127.0.0.1:42632/devtools/browser/f358209b-206a-4f4c-9a4a-54eeb41452c9\n[26042:26042:0317/010037.701230:569551012:INFO:CONSOLE(41)] \"onWebViewLoadStop\", source: chrome-extension://pkplgfpeldolfbambadcapnhgcldcpig/embedder.js (41)\n[ OK ] WebViewMediaAccessAPITest.TestCheck (2966 ms)\n[175/202] WebViewMediaAccessAPITest.TestCheck (3172 ms)\n[ RUN ] WebViewMediaAccessAPITest.TestDeny\n\nDevTools listening on ws://127.0.0.1:33284/devtools/browser/ad7cf5cf-a7fc-455f-8f0a-a4c46702b154\n[ OK ] WebViewMediaAccessAPITest.TestDeny (2829 ms)\n[176/202] WebViewMediaAccessAPITest.TestDeny (3182 ms)\n[ RUN ] WebViewMediaAccessAPITest.TestNoListenersImplyDeny\n\nDevTools listening on ws://127.0.0.1:40879/devtools/browser/c8903f9e-3c96-4f3e-919f-7ce9c52333f2\n[26364:26364:0317/010040.909641:572759418:INFO:CONSOLE(281)] \"<webview>: The permission request for \"media\" has been denied.\", source: extensions::webViewActionRequests (281)\n[ OK ] WebViewMediaAccessAPITest.TestNoListenersImplyDeny (2969 ms)\n[177/202] WebViewMediaAccessAPITest.TestNoListenersImplyDeny (3177 ms)\n[ RUN ] WebViewMediaAccessAPITest.TestDenyThenAllowThrows\n\nDevTools listening on ws://127.0.0.1:45857/devtools/browser/b3997c73-1738-4bc7-b9f6-49765b174eed\n[26362:26403:0317/010041.241062:573090823:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] WebViewMediaAccessAPITest.TestDenyThenAllowThrows (3232 ms)\n[178/202] WebViewMediaAccessAPITest.TestDenyThenAllowThrows (3441 ms)\n[ RUN ] WebViewMediaAccessAPITest.TestDenyWithPreventDefault\n\nDevTools listening on ws://127.0.0.1:44097/devtools/browser/7105c4ce-4ff9-485c-adaa-798d6b39eadf\n[26363:26395:0317/010041.088628:572938405:ERROR:browser_process_sub_thread.cc(217)] Waited 4 ms for network service\n[ OK ] WebViewMediaAccessAPITest.TestDenyWithPreventDefault (3034 ms)\n[179/202] WebViewMediaAccessAPITest.TestDenyWithPreventDefault (3437 ms)\n[ RUN ] WebViewMediaAccessAPITest.TestNoPreventDefaultImpliesDeny\n\nDevTools listening on ws://127.0.0.1:38210/devtools/browser/a2b900b4-6c95-4904-a01a-3886f82c178d\n[26568:26568:0317/010042.174969:574024741:INFO:CONSOLE(281)] \"<webview>: The permission request for \"media\" has been denied.\", source: extensions::webViewActionRequests (281)\n[26568:26581:0317/010042.427954:574277715:ERROR:browser_process_sub_thread.cc(217)] Waited 7 ms for network service\n[ OK ] WebViewMediaAccessAPITest.TestNoPreventDefaultImpliesDeny (2681 ms)\n[180/202] WebViewMediaAccessAPITest.TestNoPreventDefaultImpliesDeny (2912 ms)\n[ RUN ] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_ChainTraversalForBar\n\nDevTools listening on ws://127.0.0.1:35633/devtools/browser/31ffda4f-022a-420d-b319-0ce3113d0669\n[26714:26714:0317/010043.364660:575214430:WARNING:shell_extension_loader.cc(49)] Warnings loading extension at /b/s/w/itFPKHCN/.org.chromium.Chromium.uoL4fM:\n[26714:26714:0317/010043.365686:575215470:WARNING:shell_extension_loader.cc(52)] Unrecognized manifest key 'content_scripts'.\n[ OK ] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_ChainTraversalForBar (2207 ms)\n[181/202] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_ChainTraversalForBar (2391 ms)\n[ RUN ] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_ChainTraversalForFoo\n\nDevTools listening on ws://127.0.0.1:36351/devtools/browser/14fbe958-de49-400c-b37e-c14e757a00a7\n[26725:26725:0317/010043.503984:575353748:WARNING:shell_extension_loader.cc(49)] Warnings loading extension at /b/s/w/itFPKHCN/.org.chromium.Chromium.Y0y5H1:\n[26725:26725:0317/010043.504072:575353828:WARNING:shell_extension_loader.cc(52)] Unrecognized manifest key 'content_scripts'.\n[ OK ] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_ChainTraversalForFoo (2180 ms)\n[182/202] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_ChainTraversalForFoo (2395 ms)\n[ RUN ] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_NoMatchingOfAboutBlank\n\nDevTools listening on ws://127.0.0.1:42846/devtools/browser/0d1fe0a9-aa60-4a5d-9d08-374e58b036e3\n[26726:26726:0317/010043.455445:575305219:WARNING:shell_extension_loader.cc(49)] Warnings loading extension at /b/s/w/itFPKHCN/.org.chromium.Chromium.yP00l2:\n[26726:26726:0317/010043.455579:575305350:WARNING:shell_extension_loader.cc(52)] Unrecognized manifest key 'content_scripts'.\n[26726:26783:0317/010043.645472:575495244:ERROR:browser_process_sub_thread.cc(217)] Waited 4 ms for network service\n[ OK ] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_NoMatchingOfAboutBlank (2152 ms)\n[183/202] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_NoMatchingOfAboutBlank (2393 ms)\n[ RUN ] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_NotAllFrames\n\nDevTools listening on ws://127.0.0.1:37390/devtools/browser/8e515275-530c-4e42-b8fb-51f17fedd04f\n[26893:26893:0317/010044.533859:576383635:WARNING:shell_extension_loader.cc(49)] Warnings loading extension at /b/s/w/itFPKHCN/.org.chromium.Chromium.nm9efn:\n[26893:26893:0317/010044.533996:576383764:WARNING:shell_extension_loader.cc(52)] Unrecognized manifest key 'content_scripts'.\n[ OK ] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_NotAllFrames (2111 ms)\n[184/202] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_NotAllFrames (2401 ms)\n[ RUN ] CecPrivateKioskApiTest.TestAllApiFunctions\n\nDevTools listening on ws://127.0.0.1:39418/devtools/browser/fa3f32da-7dc8-4966-8140-a83371cb477e\n[27051:27051:0317/010045.235513:577085289:INFO:CONSOLE(0)] \"[SUCCESS] getInitialState\", source: chrome-extension://jabiebdnficieldhmegebckfhpfidfla/_generated_background_page.html (0)\n[27051:27051:0317/010045.249145:577098921:INFO:CONSOLE(0)] \"[SUCCESS] sendStandBy\", source: chrome-extension://jabiebdnficieldhmegebckfhpfidfla/_generated_background_page.html (0)\n[27051:27051:0317/010045.261393:577111165:INFO:CONSOLE(0)] \"[SUCCESS] getStandByStateState\", source: chrome-extension://jabiebdnficieldhmegebckfhpfidfla/_generated_background_page.html (0)\n[27051:27051:0317/010045.274592:577124370:INFO:CONSOLE(0)] \"[SUCCESS] sendWakeup\", source: chrome-extension://jabiebdnficieldhmegebckfhpfidfla/_generated_background_page.html (0)\n[27051:27051:0317/010045.286170:577135945:INFO:CONSOLE(0)] \"[SUCCESS] getWokeUpState\", source: chrome-extension://jabiebdnficieldhmegebckfhpfidfla/_generated_background_page.html (0)\n[27051:27106:0317/010045.355393:577205170:ERROR:browser_process_sub_thread.cc(217)] Waited 14 ms for network service\n[ OK ] CecPrivateKioskApiTest.TestAllApiFunctions (1468 ms)\n[185/202] CecPrivateKioskApiTest.TestAllApiFunctions (1865 ms)\n[ RUN ] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_CssIsIgnored\n\nDevTools listening on ws://127.0.0.1:34025/devtools/browser/56286857-394c-4eb5-9eb9-f56a65f86641\n[27040:27040:0317/010045.902162:577751934:WARNING:shell_extension_loader.cc(49)] Warnings loading extension at /b/s/w/itFPKHCN/.org.chromium.Chromium.sg8PSz:\n[27040:27040:0317/010045.902307:577752075:WARNING:shell_extension_loader.cc(52)] Unrecognized manifest key 'content_scripts'.\n[ OK ] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_CssIsIgnored (2189 ms)\n[186/202] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_CssIsIgnored (2397 ms)\n[ RUN ] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_NotYetCommittedURL\n\nDevTools listening on ws://127.0.0.1:36431/devtools/browser/2cd1bfd7-3541-4e88-8f90-5e14c401ef37\n[27010:27010:0317/010045.876080:577725858:WARNING:shell_extension_loader.cc(49)] Warnings loading extension at /b/s/w/itFPKHCN/.org.chromium.Chromium.q7cwAp:\n[27010:27010:0317/010045.876209:577725976:WARNING:shell_extension_loader.cc(52)] Unrecognized manifest key 'content_scripts'.\n[ OK ] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_NotYetCommittedURL (2268 ms)\n[187/202] URLLoaderFactoryManagerBrowserTest.ContentScriptMatching_NotYetCommittedURL (2656 ms)\n[ RUN ] CecPrivateNonKioskApiTest.TestCecPrivateNotAvailable\n\nDevTools listening on ws://127.0.0.1:38242/devtools/browser/d320972c-cedc-4c5d-b727-2f4adb3a2439\n[27225:27225:0317/010045.642758:577492543:WARNING:shell_extension_loader.cc(49)] Warnings loading extension at /b/s/w/ir/extensions/test/data/api_test/cec_private/non_kiosk_api_not_available:\n[27225:27225:0317/010045.642934:577492706:WARNING:shell_extension_loader.cc(52)] 'cecPrivate' is only allowed to run in kiosk apps sessions, but this is user-less session.\n[27225:27225:0317/010046.189881:578039652:INFO:CONSOLE(0)] \"[SUCCESS] ensureCecPrivateNotDefined\", source: chrome-extension://jabiebdnficieldhmegebckfhpfidfla/_generated_background_page.html (0)\n[27225:27284:0317/010046.264377:578114150:ERROR:browser_process_sub_thread.cc(217)] Waited 3 ms for network service\n[ OK ] CecPrivateNonKioskApiTest.TestCecPrivateNotAvailable (1180 ms)\n[188/202] CecPrivateNonKioskApiTest.TestCecPrivateNotAvailable (1624 ms)\n[ RUN ] MediaPerceptionPrivateApiTest.SetAnalyticsComponent\n\nDevTools listening on ws://127.0.0.1:41732/devtools/browser/b7fac3fa-fcf1-40b4-b5af-33fb93875e96\n[27314:27314:0317/010046.361891:578211654:ERROR:network_profile_handler.cc(83)] Manager properties returned from Shill don't contain the field Profiles\n[27314:27314:0317/010046.362078:578211837:ERROR:network_sms_handler.cc(436)] NetworkSmsHandler: No list value for: Devices\n[27314:27314:0317/010046.852721:578702498:INFO:CONSOLE(0)] \"[SUCCESS] setAnalyticsComponentLight\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27314:27314:0317/010046.863552:578713333:INFO:CONSOLE(0)] \"[SUCCESS] setAnalyticsComponentFullExpectFailure\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27314:27314:0317/010046.875282:578725055:INFO:CONSOLE(0)] \"[SUCCESS] setAnalyticsComponentWithProcessRunningSuccess\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[ OK ] MediaPerceptionPrivateApiTest.SetAnalyticsComponent (1129 ms)\n[189/202] MediaPerceptionPrivateApiTest.SetAnalyticsComponent (1363 ms)\n[ RUN ] MediaPerceptionPrivateApiTest.SetComponentProcessState\n[27388:27388:0317/010047.088784:578938558:ERROR:network_profile_handler.cc(83)] Manager properties returned from Shill don't contain the field Profiles\n[27388:27388:0317/010047.089058:578938826:ERROR:network_sms_handler.cc(436)] NetworkSmsHandler: No list value for: Devices\n\nDevTools listening on ws://127.0.0.1:34387/devtools/browser/4384a4c5-beed-4d62-848e-ed554a04233c\n[27388:27388:0317/010047.927448:579777264:INFO:CONSOLE(0)] \"[SUCCESS] setComponentProcessStateStartedWithNoInstalledComponent\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27388:27388:0317/010047.977122:579826895:INFO:CONSOLE(0)] \"[SUCCESS] setAnalyticsComponentLight\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27388:27388:0317/010047.988412:579838185:ERROR:media_perception_private_apitest.cc(59)] Not implemented reached in virtual void extensions::(anonymous namespace)::TestMediaPerceptionAPIDelegate::SetMediaPerceptionRequestHandler(extensions::MediaPerceptionAPIDelegate::MediaPerceptionRequestHandler)\n[27388:27388:0317/010047.999236:579849014:INFO:CONSOLE(0)] \"[SUCCESS] setComponentProcessStateStarted\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27388:27388:0317/010048.026672:579876446:INFO:CONSOLE(0)] \"[SUCCESS] setComponentProcessStateStopped\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27388:27388:0317/010048.049657:579899428:INFO:CONSOLE(0)] \"[SUCCESS] setComponentProcessStateUnsettable\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[ OK ] MediaPerceptionPrivateApiTest.SetComponentProcessState (1878 ms)\n[190/202] MediaPerceptionPrivateApiTest.SetComponentProcessState (2123 ms)\n[ RUN ] MediaPerceptionPrivateApiTest.State\n\nDevTools listening on ws://127.0.0.1:44364/devtools/browser/13c103ec-580b-44e6-841f-2cb4ea5ae973\n[27397:27397:0317/010047.072874:578922652:ERROR:network_profile_handler.cc(83)] Manager properties returned from Shill don't contain the field Profiles\n[27397:27397:0317/010047.073140:578922917:ERROR:network_sms_handler.cc(436)] NetworkSmsHandler: No list value for: Devices\n[27397:27397:0317/010047.819590:579669365:INFO:CONSOLE(0)] \"[SUCCESS] getStateUninitialized\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27397:27397:0317/010047.848166:579697953:INFO:CONSOLE(0)] \"[SUCCESS] setStateRunning\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27397:27397:0317/010047.878677:579728452:INFO:CONSOLE(0)] \"[SUCCESS] getStateRunning\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27397:27397:0317/010047.925064:579774835:INFO:CONSOLE(0)] \"[SUCCESS] setStateUnsettable\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27397:27397:0317/010047.936689:579786460:INFO:CONSOLE(0)] \"[SUCCESS] setStateSuspendedButWithDeviceContextFail\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27397:27397:0317/010047.957737:579807508:INFO:CONSOLE(0)] \"[SUCCESS] setStateSuspendedButWithConfigurationFail\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27397:27397:0317/010047.974238:579824027:INFO:CONSOLE(0)] \"[SUCCESS] setStateSuspendedButWithWhiteboardFail\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27397:27397:0317/010047.990193:579839963:INFO:CONSOLE(0)] \"[SUCCESS] setStateSuspendedButWithVideoStreamParamFail\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27397:27397:0317/010048.018321:579868095:INFO:CONSOLE(0)] \"[SUCCESS] setStateRestarted\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27397:27397:0317/010048.031263:579881035:INFO:CONSOLE(0)] \"[SUCCESS] setStateRunningWithoutOptionalParameters\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27397:27397:0317/010048.046320:579896096:INFO:CONSOLE(0)] \"[SUCCESS] setStateStopped\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[ OK ] MediaPerceptionPrivateApiTest.State (1784 ms)\n[191/202] MediaPerceptionPrivateApiTest.State (2122 ms)\n[ RUN ] MediaPerceptionPrivateApiTest.MediaPerception\n[27491:27491:0317/010047.659227:579509001:ERROR:network_profile_handler.cc(83)] Manager properties returned from Shill don't contain the field Profiles\n[27491:27491:0317/010047.659486:579509252:ERROR:network_sms_handler.cc(436)] NetworkSmsHandler: No list value for: Devices\n\nDevTools listening on ws://127.0.0.1:38806/devtools/browser/ba3eea5f-2bb3-4131-9ab0-8901c91913a3\n[27491:27491:0317/010048.321616:580171390:INFO:CONSOLE(0)] \"[SUCCESS] setStateRunning\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27491:27491:0317/010048.336531:580186294:INFO:CONSOLE(0)] \"[SUCCESS] registerListener\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[ OK ] MediaPerceptionPrivateApiTest.MediaPerception (1244 ms)\n[192/202] MediaPerceptionPrivateApiTest.MediaPerception (1601 ms)\n[ RUN ] MediaPerceptionPrivateApiTest.GetDiagnostics\n\nDevTools listening on ws://127.0.0.1:38804/devtools/browser/f57c6ed3-367f-486f-bd45-090a5d7406b7\n[27437:27437:0317/010047.716193:579565977:ERROR:network_profile_handler.cc(83)] Manager properties returned from Shill don't contain the field Profiles\n[27437:27437:0317/010047.716497:579566282:ERROR:network_sms_handler.cc(436)] NetworkSmsHandler: No list value for: Devices\n[27437:27437:0317/010048.344329:580194111:INFO:CONSOLE(0)] \"[SUCCESS] setStateRunning\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[27437:27437:0317/010048.365982:580215793:INFO:CONSOLE(0)] \"[SUCCESS] getDiagnostics\", source: chrome-extension://epcifkihnkjgphfkloaaleeakhpmgdmn/_generated_background_page.html (0)\n[ OK ] MediaPerceptionPrivateApiTest.GetDiagnostics (1725 ms)\n[193/202] MediaPerceptionPrivateApiTest.GetDiagnostics (2134 ms)\n[ RUN ] SystemPowerSourceApiTest.TestAllApiFunctions\n\nDevTools listening on ws://127.0.0.1:40088/devtools/browser/9a8919cd-4084-4d55-9746-9971e39789f4\n[27709:27709:0317/010050.043755:581893538:INFO:CONSOLE(0)] \"[SUCCESS] getPowerSourceInfo\", source: chrome-extension://oaadedlfjikeejoppbckfeciddilknjg/_generated_background_page.html (0)\n[27709:27709:0317/010050.060818:581910581:INFO:CONSOLE(0)] \"[SUCCESS] onPowerChanged\", source: chrome-extension://oaadedlfjikeejoppbckfeciddilknjg/_generated_background_page.html (0)\n[ OK ] SystemPowerSourceApiTest.TestAllApiFunctions (1753 ms)\n[194/202] SystemPowerSourceApiTest.TestAllApiFunctions (2126 ms)\n[ RUN ] VirtualKeyboardApiTest.Test\n\nDevTools listening on ws://127.0.0.1:37256/devtools/browser/0635c477-dfd6-4e8f-aa3f-bb3a3aa24b89\n[27710:27710:0317/010050.121775:581971558:INFO:CONSOLE(0)] \"[SUCCESS] setRestrictedKeyboard\", source: chrome-extension://gilafhccpgkdkadmiohlelonjjflphdc/_generated_background_page.html (0)\n[27710:27710:0317/010050.138743:581988516:INFO:CONSOLE(0)] \"[SUCCESS] setNotRestrictedKeyboard\", source: chrome-extension://gilafhccpgkdkadmiohlelonjjflphdc/_generated_background_page.html (0)\n[27710:27710:0317/010050.145179:581994953:INFO:CONSOLE(0)] \"[SUCCESS] differentAndPartialEnabledStates\", source: chrome-extension://gilafhccpgkdkadmiohlelonjjflphdc/_generated_background_page.html (0)\n[ OK ] VirtualKeyboardApiTest.Test (1733 ms)\n[195/202] VirtualKeyboardApiTest.Test (2139 ms)\n[ RUN ] ShellRuntimeApiTest.RuntimeReload\n\nDevTools listening on ws://127.0.0.1:39128/devtools/browser/8ea04918-11f9-48ff-8318-5a283678c627\n[27724:27790:0317/010050.467370:582317132:ERROR:browser_process_sub_thread.cc(217)] Waited 5 ms for network service\n[ OK ] ShellRuntimeApiTest.RuntimeReload (1747 ms)\n[196/202] ShellRuntimeApiTest.RuntimeReload (2130 ms)\n[ RUN ] ShellRuntimeApiTest.RuntimeReloadApp\n\nDevTools listening on ws://127.0.0.1:37093/devtools/browser/10680f06-036e-49e8-b0d0-a810c76cb56b\n[27725:27725:0317/010050.542620:582392388:INFO:CONSOLE(6)] \"app window opened\", source: chrome-extension://hcilemblcaaimepojbkmnkcocgbmfoea/world.js (6)\n[27725:27725:0317/010051.049578:582899361:INFO:CONSOLE(6)] \"app window opened\", source: chrome-extension://hcilemblcaaimepojbkmnkcocgbmfoea/world.js (6)\n[ OK ] ShellRuntimeApiTest.RuntimeReloadApp (2325 ms)\n[197/202] ShellRuntimeApiTest.RuntimeReloadApp (2656 ms)\n[ RUN ] ShellApiTest.LoadExtension\n\nDevTools listening on ws://127.0.0.1:35320/devtools/browser/97380c9d-6a9e-4494-a6de-50db6ce74ace\n[ OK ] ShellApiTest.LoadExtension (1461 ms)\n[198/202] ShellApiTest.LoadExtension (1868 ms)\n[ RUN ] ShellApiTest.LoadApp\n\nDevTools listening on ws://127.0.0.1:40030/devtools/browser/64f99fc0-e596-4697-b663-a2a451719cf8\n[27991:27991:0317/010052.440721:584290501:INFO:CONSOLE(6)] \"app window opened\", source: chrome-extension://hcilemblcaaimepojbkmnkcocgbmfoea/world.js (6)\n[ OK ] ShellApiTest.LoadApp (1946 ms)\n[199/202] ShellApiTest.LoadApp (2397 ms)\n[ RUN ] ShellDesktopControllerAuraBrowserTest.CloseAppWindow\n\nDevTools listening on ws://127.0.0.1:38659/devtools/browser/ca9db7a7-f7f0-4345-826e-2fd92e911ec2\n[28013:28013:0317/010052.573389:584423151:INFO:CONSOLE(6)] \"app window opened\", source: chrome-extension://hcilemblcaaimepojbkmnkcocgbmfoea/world.js (6)\n[ OK ] ShellDesktopControllerAuraBrowserTest.CloseAppWindow (1790 ms)\n[200/202] ShellDesktopControllerAuraBrowserTest.CloseAppWindow (2136 ms)\n[ RUN ] ShellDesktopControllerAuraBrowserTest.TwoAppWindows\n\nDevTools listening on ws://127.0.0.1:38785/devtools/browser/9590c9be-8f0b-416f-a97a-4d6f16cc1c18\n[28091:28091:0317/010052.903066:584752844:INFO:CONSOLE(6)] \"app window opened\", source: chrome-extension://hcilemblcaaimepojbkmnkcocgbmfoea/world.js (6)\n[28091:28091:0317/010053.214528:585064292:INFO:CONSOLE(6)] \"app window opened\", source: chrome-extension://hcilemblcaaimepojbkmnkcocgbmfoea/world.js (6)\n[ OK ] ShellDesktopControllerAuraBrowserTest.TwoAppWindows (2208 ms)\n[201/202] ShellDesktopControllerAuraBrowserTest.TwoAppWindows (2688 ms)\n[ RUN ] ShellDesktopControllerAuraBrowserTest.ReloadApp\n\nDevTools listening on ws://127.0.0.1:32830/devtools/browser/83ed33e8-a463-419c-91e4-87da68049a2b\n[28241:28241:0317/010053.805678:585655451:INFO:CONSOLE(6)] \"app window opened\", source: chrome-extension://hcilemblcaaimepojbkmnkcocgbmfoea/world.js (6)\n[28241:28241:0317/010054.306407:586156169:INFO:CONSOLE(6)] \"app window opened\", source: chrome-extension://hcilemblcaaimepojbkmnkcocgbmfoea/world.js (6)\n[28241:28291:0317/010054.885380:586735140:ERROR:browser_process_sub_thread.cc(217)] Waited 1 ms for network service\n[ OK ] ShellDesktopControllerAuraBrowserTest.ReloadApp (2485 ms)\n[202/202] ShellDesktopControllerAuraBrowserTest.ReloadApp (2928 ms)\nSUCCESS: all tests passed.\n", "outputs_ref": { "isolated": "dadade1ec13761311f4133998800358bed5e0f2f", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "43a3795083ac9d11", "server_versions": [ "4201-b04f7f8" ], "started_ts": "2019-03-17T07:57:25.773680", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:Linux ChromiumOS MSan Tests", "buildnumber:11842", "cpu:x86-64", "data:7ad0ffe58ba0f2ad16deb718b3a9cb2b63d827df", "gpu:none", "master:chromium.memory", "name:extensions_browsertests", "os:Ubuntu-14.04", "pool:Chrome", "priority:25", "project:chromium", "purpose:CI", "purpose:luci", "purpose:post-commit", "service_account:none", "slavename:swarm2374-c4", "spec_name:chromium.ci:Linux ChromiumOS MSan Tests", "stepname:extensions_browsertests", "swarming.pool.template:none", "swarming.pool.version:84dc2e055f380db17943d027893da36f2780b31c", "user:None" ], "task_id": "43a3795083ac9d10", "try_number": "1" } ] }