------------------------------------------------
RUNNING TEST: /pkgfs/packages/driver_example_mod_tests/0/test/driver_example_mod_tests
[INFO:main.cc(35)] Trace Manager starting with config: /pkg/data/tracing.config
00:00 +0: driver example tests (setUpAll)
[INFO:input_interpreter.cc(388)] Can't process HID report descriptor for 000; All parsing attempts failed.
[INFO:a11y_input_system.cc(11)] Scenic accessibility input system started.
[INFO:display_watcher.cc(40)] Scenic: Acquired display controller /dev/class/display-controller/000.(000)
[INFO:input_system.cc(203)] Scenic input system initialized.
[WARNING:garnet/bin/ui/root_presenter/displays/display_configuration.cc(76)] SceneManager: unrecognized display.
[INFO:input_system.cc(556)] Scenic: Parallel dispatch is turned OFF
[INFO:display_configuration.cc(122)] SceneManager: Display metrics: width_in_px=1920, height_in_px=1080, width_in_pp=1117.09, height_in_pp=628.364, width_in_mm=213.333, height_in_mm=120, x_scale_in_px_per_pp=1.71875, y_scale_in_px_per_pp=1.71875, x_scale_in_pp_per_px=0.581818, y_scale_in_pp_per_px=0.581818, density_in_pp_per_mm=5.23636, density_in_mm_per_pp=0.190972
[WARNING:garnet/bin/ui/root_presenter/displays/display_configuration.cc(76)] SceneManager: unrecognized display.
[INFO:display_configuration.cc(122)] SceneManager: Display metrics: width_in_px=1920, height_in_px=1080, width_in_pp=1117.09, height_in_pp=628.364, width_in_mm=213.333, height_in_mm=120, x_scale_in_px_per_pp=1.71875, y_scale_in_px_per_pp=1.71875, x_scale_in_pp_per_px=0.581818, y_scale_in_pp_per_px=0.581818, density_in_pp_per_mm=5.23636, density_in_mm_per_pp=0.190972
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 2 presentation_time: 0
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 3 presentation_time: 0
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 4 presentation_time: 0
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 5 presentation_time: 0
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(144)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=16506159980574 wakeup_time=16506151980574 frame_number=0
[INFO:default_frame_scheduler.cc(236)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=16506159980574 frame_number=0
[INFO:default_frame_scheduler.cc(179)] DefaultFrameScheduler: calling RenderFrame presentation_time=16506159980574 frame_number=0
[WARNING:garnet/lib/ui/gfx/gfx_system.cc(315)] ## Vulkan Warning: Object: 0x156 (Type = 5) | vkQueueSubmit(): Signaling external semaphore 0x156 on queue 0x1f996805d1e0 will disable validation of preceding command buffer lifecycle states and the in-use status of associated objects. (layer: Validation code: 79 object-type: Semaphore object: 342)
[ERROR:garnet/bin/ui/root_presenter/app.cc(267)] Root presenter: Content view terminated unexpectedly.
[INFO:default_frame_scheduler.cc(268)] DefaultFrameScheduler::OnFramePresented frame_number=0
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 3 presentation_time: 16506196831688
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 2 presentation_time: 16506196831688
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 4 presentation_time: 16506196831688
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(144)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=16506196831688 wakeup_time=16506188831688 frame_number=1
[INFO:default_frame_scheduler.cc(236)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=16506196831688 frame_number=1
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(144)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=16506213498355 wakeup_time=16506205498355 frame_number=1
[INFO:default_frame_scheduler.cc(236)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=16506213498355 frame_number=1
[INFO:default_frame_scheduler.cc(179)] DefaultFrameScheduler: calling RenderFrame presentation_time=16506213498355 frame_number=1
[INFO:default_frame_scheduler.cc(268)] DefaultFrameScheduler::OnFramePresented frame_number=1
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 4 presentation_time: 16506230164729
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 3 presentation_time: 16506230164729
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(144)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=16506230164729 wakeup_time=16506222164729 frame_number=2
[INFO:default_frame_scheduler.cc(236)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=16506230164729 frame_number=2
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(144)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=16506246830234 wakeup_time=16506238830234 frame_number=2
[INFO:default_frame_scheduler.cc(236)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=16506246830234 frame_number=2
[INFO:default_frame_scheduler.cc(179)] DefaultFrameScheduler: calling RenderFrame presentation_time=16506246830234 frame_number=2
[INFO:default_frame_scheduler.cc(268)] DefaultFrameScheduler::OnFramePresented frame_number=2
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 4 presentation_time: 16506263501035
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(144)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=16506263501035 wakeup_time=16506255501035 frame_number=3
[INFO:default_frame_scheduler.cc(236)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=16506263501035 frame_number=3
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(144)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=16506280168409 wakeup_time=16506272168409 frame_number=3
[INFO:default_frame_scheduler.cc(236)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=16506280168409 frame_number=3
[INFO:default_frame_scheduler.cc(179)] DefaultFrameScheduler: calling RenderFrame presentation_time=16506280168409 frame_number=3
[INFO:default_frame_scheduler.cc(268)] DefaultFrameScheduler::OnFramePresented frame_number=3
[info ] FlutterDriver: Connecting to Flutter application at ws://127.0.0.1:56648/ws
[trace] FlutterDriver: Isolate found with number: 499160272
[INFO:default_frame_scheduler.cc(222)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 5 presentation_time: 0
[INFO:default_frame_scheduler.cc(111)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(144)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=16506696835017 wakeup_time=16506688835017 frame_number=4
[INFO:default_frame_scheduler.cc(236)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=16506696835017 frame_number=4
[INFO:default_frame_scheduler.cc(179)] DefaultFrameScheduler: calling RenderFrame presentation_time=16506696835017 frame_number=4
[trace] FlutterDriver: Isolate is not paused. Assuming application is ready.
[info ] FlutterDriver: >>> {command: get_health}
[info ] FlutterDriver: <<< {isError: false, response: {status: ok}, type: _extensionType, method: ext.flutter.driver}
[info ] FlutterDriver: Connected to Flutter application.
00:02 +0: driver example tests driver connection
00:02 +1: driver example tests add to counter. remove from counter
00:02 +1: driver example tests (setUpAll)
[info ] FlutterDriver: >>> {command: tap, finderType: ByText, text: +1}
[info ] FlutterDriver: <<< {isError: false, response: {}, type: _extensionType, method: ext.flutter.driver}
[info ] FlutterDriver: >>> {command: tap, finderType: ByText, text: +1}
[info ] FlutterDriver: <<< {isError: false, response: {}, type: _extensionType, method: ext.flutter.driver}
[info ] FlutterDriver: >>> {command: tap, finderType: ByText, text: +5}
[info ] FlutterDriver: <<< {isError: false, response: {}, type: _extensionType, method: ext.flutter.driver}
[info ] FlutterDriver: >>> {command: tap, finderType: ByText, text: -1}
[info ] FlutterDriver: <<< {isError: false, response: {}, type: _extensionType, method: ext.flutter.driver}
[info ] FlutterDriver: >>> {command: tap, finderType: ByText, text: This counter has a value of: 6}
[info ] FlutterDriver: <<< {isError: false, response: {}, type: _extensionType, method: ext.flutter.driver}
[info ] FlutterDriver: >>> {command: tap, finderType: ByText, text: -5}
[info ] FlutterDriver: <<< {isError: false, response: {}, type: _extensionType, method: ext.flutter.driver}
[info ] FlutterDriver: >>> {command: tap, finderType: ByText, text: -1}
[info ] FlutterDriver: <<< {isError: false, response: {}, type: _extensionType, method: ext.flutter.driver}
[info ] FlutterDriver: >>> {command: tap, finderType: ByText, text: This counter has a value of: 0}
[info ] FlutterDriver: <<< {isError: false, response: {}, type: _extensionType, method: ext.flutter.driver}
00:04 +2: driver example tests (tearDownAll)
[ERROR:garnet/bin/ui/root_presenter/app.cc(267)] Root presenter: Content view terminated unexpectedly.
00:04 +2: All tests passed!
[ERROR:garnet/lib/ui/input/input_system.cc(200)] Scenic lost connection to TextSync
SUMMARY: Ran 1 tests: 0 failed (4.660 sec)
PASSED: /pkgfs/packages/driver_example_mod_tests/0/test/driver_example_mod_tests passed