------------------------------------------------
RUNNING TEST: /pkgfs/packages/slider_mod_tests/0/test/slider_mod_tests
[INFO:main.cc(35)] Trace Manager starting with config: /pkg/data/tracing.config
00:00 +0: (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(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 2 presentation_time: 0
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 3 presentation_time: 0
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 4 presentation_time: 0
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 5 presentation_time: 0
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 1 presentation_time: 0
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(148)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=5727167744794 wakeup_time=5727159744794 frame_number=0
[INFO:default_frame_scheduler.cc(248)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=5727167744794 frame_number=0
[INFO:default_frame_scheduler.cc(188)] DefaultFrameScheduler: calling RenderFrame presentation_time=5727167744794 frame_number=0
[WARNING:garnet/lib/ui/gfx/gfx_system.cc(315)] ## Vulkan Warning: Object: 0x157 (Type = 5) | vkQueueSubmit(): Signaling external semaphore 0x157 on queue 0x49ab7cabf1e0 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: 343)
[ERROR:garnet/bin/ui/root_presenter/app.cc(267)] Root presenter: Content view terminated unexpectedly.
[INFO:default_frame_scheduler.cc(280)] DefaultFrameScheduler::OnFramePresented frame_number=0
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 4 presentation_time: 5727213674759
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 2 presentation_time: 5727213674759
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 3 presentation_time: 5727213674759
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(148)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=5727213674759 wakeup_time=5727205674759 frame_number=1
[INFO:default_frame_scheduler.cc(248)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=5727213674759 frame_number=1
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[fine]::FuchsiaRemoteConnection--2019-04-19 18:59:45.482577: No live Dart VMs found. Awaiting new VM startup
[INFO:default_frame_scheduler.cc(148)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=5727230341426 wakeup_time=5727222341426 frame_number=1
[INFO:default_frame_scheduler.cc(248)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=5727230341426 frame_number=1
[INFO:default_frame_scheduler.cc(188)] DefaultFrameScheduler: calling RenderFrame presentation_time=5727230341426 frame_number=1
[INFO:default_frame_scheduler.cc(280)] DefaultFrameScheduler::OnFramePresented frame_number=1
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 4 presentation_time: 5727247009871
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 3 presentation_time: 5727247009871
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(148)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=5727247009871 wakeup_time=5727239009871 frame_number=2
[INFO:default_frame_scheduler.cc(248)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=5727247009871 frame_number=2
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(148)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=5727263677132 wakeup_time=5727255677132 frame_number=2
[INFO:default_frame_scheduler.cc(248)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=5727263677132 frame_number=2
[INFO:default_frame_scheduler.cc(188)] DefaultFrameScheduler: calling RenderFrame presentation_time=5727263677132 frame_number=2
[INFO:default_frame_scheduler.cc(280)] DefaultFrameScheduler::OnFramePresented frame_number=2
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 4 presentation_time: 5727280342486
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(148)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=5727280342486 wakeup_time=5727272342486 frame_number=3
[INFO:default_frame_scheduler.cc(248)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=5727280342486 frame_number=3
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[INFO:default_frame_scheduler.cc(148)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=5727297008829 wakeup_time=5727289008829 frame_number=3
[INFO:default_frame_scheduler.cc(248)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=5727297008829 frame_number=3
[INFO:default_frame_scheduler.cc(188)] DefaultFrameScheduler: calling RenderFrame presentation_time=5727297008829 frame_number=3
[INFO:default_frame_scheduler.cc(280)] DefaultFrameScheduler::OnFramePresented frame_number=3
[fine]::FuchsiaRemoteConnection--2019-04-19 18:59:45.995874: New VM found on port: 53794. Searching for Isolate: slider_mod.cmx
[fine]::DartVm--2019-04-19 18:59:46.109575: Found Isolate matching "slider_mod.cmx": "slider_mod.cmx"
[info ] FlutterDriver: Connecting to Flutter application at ws://127.0.0.1:53794/ws
[trace] FlutterDriver: Isolate found with number: 67773810
[INFO:default_frame_scheduler.cc(234)] DefaultFrameScheduler::ScheduleUpdateForSession session_id: 5 presentation_time: 0
[INFO:default_frame_scheduler.cc(115)] DefaultFrameScheduler::RequestFrame
[trace] FlutterDriver: Isolate is not paused. Assuming application is ready.
[INFO:default_frame_scheduler.cc(148)] DefaultFrameScheduler::MaybeRenderFrame presentation_time=5728047011210 wakeup_time=5728039011210 frame_number=4
[INFO:default_frame_scheduler.cc(248)] DefaultFrameScheduler::ApplyScheduledSessionUpdates presentation_time=5728047011210 frame_number=4
[INFO:default_frame_scheduler.cc(188)] DefaultFrameScheduler: calling RenderFrame presentation_time=5728047011210 frame_number=4
[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: Verify the agent is connected and replies with the correct Fibonacci result
tapping on Calc Fibonacci button
00:02 +0: (setUpAll)
[info ] FlutterDriver: >>> {command: tap, finderType: ByText, text: Calc Fibonacci}
[info ] FlutterDriver: <<< {isError: false, response: {}, type: _extensionType, method: ext.flutter.driver}
00:02 +0: Verify the agent is connected and replies with the correct Fibonacci result
verifying the result
00:02 +0: (setUpAll)
[info ] FlutterDriver: >>> {command: waitFor, finderType: ByValueKey, keyValueString: fib-result-widget-key, keyValueType: String}
[info ] FlutterDriver: <<< {isError: false, response: {}, type: _extensionType, method: ext.flutter.driver}
00:03 +0: Verify the agent is connected and replies with the correct Fibonacci result
test is finished successfully
00:03 +1: (tearDownAll)
[ERROR:garnet/bin/ui/root_presenter/app.cc(267)] Root presenter: Content view terminated unexpectedly.
00:03 +1: All tests passed!
[ERROR:garnet/lib/ui/input/input_system.cc(200)] Scenic lost connection to TextSync
SUMMARY: Ran 1 tests: 0 failed (3.499 sec)
PASSED: /pkgfs/packages/slider_mod_tests/0/test/slider_mod_tests passed