Device does not connect at all

[MilanBabuljak]

Platform: Raspbian Lastest [RPI 4 B+ 4G] / Android Auto
Phone: Samsung Galaxy Note 10

When connecting, connection fails:

[18:43:28.374] ══════ SESSIONS · create #1 androidauto in={"instanceId":"","ip":"127.0.0.1"} ══════
  #1  androidauto usb  held   main:- cluster:-         keys: inst= ip=127.0.0.1
[18:43:28.375] [ProjectionService] active session -> #1 androidauto
[18:43:28.375] [SESSIONS] codec-restore #1 androidauto: session=- map=- → gstVideoCodec=h264
[18:43:28.375] ══════ SESSIONS · activate #1 androidauto (prev none) ══════
  #1  androidauto usb  ACTIVE main:- cluster:-         keys: inst= ip=127.0.0.1
[18:43:28.447] [ControlChannel] AudioFocusRequest raw: 0804
[18:43:28.447] [ControlChannel] AudioFocus type=4(RELEASE) → state=3(LOSS)
[18:43:28.465] [AaEventBridge] video-codec=h265 (phone selection)
[18:43:28.465] ══════ SESSIONS · video-codec h265 → stored on #1 ══════
  #1  androidauto usb  ACTIVE main:h265 cluster:-      keys: inst= ip=127.0.0.1
[18:43:28.466] [Session] ★ phone picked video codec: H265 (offered: h264, h265)
[18:43:28.466] [AaEventBridge] AAStack connected
[18:43:28.467] ══════ SESSIONS · upsert #1 androidauto in={} ══════
  #1  androidauto usb  ACTIVE main:h265 cluster:-      keys: inst= ip=127.0.0.1
[18:43:28.469] [AudioChannel:media] setup codec=1 48000Hz 2ch
[18:43:28.469] [AudioChannel:speech] setup codec=1 16000Hz 1ch
[18:43:28.470] [AudioChannel:phone] setup codec=1 16000Hz 1ch
[18:43:30.884] [AaManager] wired bridge error: transferOut error: Cancelled
[18:43:30.885] [AaManager] wired bridge error: transferOut error: Cancelled

Any idea how to debug / test this? Thanks

[f-io]

Hi @MilanBabuljak, the phone is connecting and even negotiates a codec, so we need deeper logging to see where it drops.
Please run: LIVI_GST_DEBUG=1 ./LIVI*.AppImage and attach the full log. Also please avoid 1080p while testing (a lower resolution helps rule out a resolution-specific HEVC decode issue), 720p is a good one to start with.

As I see you are using a dev build, please make sure you use this one: https://github.com/f-io/LIVI/actions/runs/29520511301

[MilanBabuljak]

Hi, thanks for the response, here is the log:

milan@raspberrypi:~ $ LIVI_GST_DEBUG=1 ./LIVI*.AppImage
[19:56:03.263] [config] Written corrected config.json
milan@raspberrypi:~ $ 00:00:00.000 [backend/wayland/backend.c:587] Creating wayland backend
00:00:00.068 [render/egl.c:205] Supported EGL client extensions: EGL_EXT_device_base EGL_EXT_device_enumeration EGL_EXT_device_query EGL_EXT_platform_base EGL_KHR_client_get_all_proc_addresses EGL_EXT_client_extensions EGL_KHR_debug EGL_EXT_platform_device EGL_EXT_explicit_device EGL_EXT_platform_wayland EGL_KHR_platform_wayland EGL_EXT_platform_x11 EGL_KHR_platform_x11 EGL_EXT_platform_xcb EGL_MESA_platform_gbm EGL_KHR_platform_gbm EGL_MESA_platform_surfaceless
00:00:00.100 [render/egl.c:369] Using EGL 1.5
00:00:00.100 [render/egl.c:370] Supported EGL display extensions: EGL_ANDROID_blob_cache EGL_ANDROID_native_fence_sync EGL_EXT_buffer_age EGL_EXT_config_select_group EGL_EXT_image_dma_buf_import EGL_EXT_image_dma_buf_import_modifiers EGL_EXT_surface_compression EGL_KHR_cl_event2 EGL_KHR_config_attribs EGL_KHR_context_flush_control EGL_KHR_create_context EGL_KHR_create_context_no_error EGL_KHR_fence_sync EGL_KHR_get_all_proc_addresses EGL_KHR_gl_colorspace EGL_KHR_gl_renderbuffer_image EGL_KHR_gl_texture_2D_image EGL_KHR_gl_texture_3D_image EGL_KHR_gl_texture_cubemap_image EGL_KHR_image EGL_KHR_image_base EGL_KHR_image_pixmap EGL_KHR_no_config_context EGL_KHR_reusable_sync EGL_KHR_surfaceless_context EGL_EXT_pixel_format_float EGL_KHR_wait_sync EGL_MESA_configless_context EGL_MESA_drm_image EGL_MESA_gl_interop EGL_MESA_image_dma_buf_export EGL_MESA_query_driver EGL_MESA_x11_native_visual_id EGL_WL_bind_wayland_display 
00:00:00.100 [render/egl.c:372] Supported EGL device extensions: EGL_EXT_device_drm EGL_EXT_device_drm_render_node
00:00:00.100 [render/egl.c:374] EGL vendor: Mesa Project
00:00:00.108 [render/gles2/renderer.c:538] Creating GLES2 renderer
00:00:00.108 [render/gles2/renderer.c:539] Using OpenGL ES 3.1 Mesa 25.0.7-2+rpt4
00:00:00.108 [render/gles2/renderer.c:540] GL vendor: Broadcom
00:00:00.108 [render/gles2/renderer.c:541] GL renderer: V3D 4.2.14.0
00:00:00.108 [render/gles2/renderer.c:542] Supported GLES2 extensions: GL_EXT_blend_minmax GL_EXT_multi_draw_arrays GL_EXT_texture_filter_anisotropic GL_EXT_texture_compression_s3tc GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_rgtc GL_EXT_texture_format_BGRA8888 GL_OES_compressed_ETC1_RGB8_texture GL_OES_depth24 GL_OES_element_index_uint GL_OES_fbo_render_mipmap GL_OES_mapbuffer GL_OES_rgb8_rgba8 GL_OES_standard_derivatives GL_OES_stencil8 GL_OES_texture_3D GL_OES_texture_float GL_OES_texture_half_float GL_OES_texture_half_float_linear GL_OES_texture_npot GL_OES_vertex_half_float GL_EXT_draw_instanced GL_EXT_texture_sRGB_decode GL_OES_EGL_image GL_OES_depth_texture GL_AMD_performance_monitor GL_OES_packed_depth_stencil GL_EXT_texture_type_2_10_10_10_REV GL_NV_conditional_render GL_OES_get_program_binary GL_APPLE_texture_max_level GL_EXT_discard_framebuffer GL_EXT_read_format_bgra GL_EXT_texture_storage GL_NV_pack_subimage GL_NV_texture_barrier GL_EXT_frag_depth GL_NV_fbo_color_attachments GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_vertex_array_object GL_ANGLE_pack_reverse_row_order GL_ANGLE_texture_compression_dxt3 GL_ANGLE_texture_compression_dxt5 GL_EXT_occlusion_query_boolean GL_EXT_texture_rg GL_EXT_unpack_subimage GL_NV_draw_buffers GL_NV_read_buffer GL_NV_read_depth GL_NV_read_depth_stencil GL_NV_read_stencil GL_APPLE_sync GL_EXT_draw_buffers GL_EXT_instanced_arrays GL_EXT_map_buffer_range GL_EXT_shadow_samplers GL_KHR_debug GL_KHR_texture_compression_astc_ldr GL_NV_generate_mipmap_sRGB GL_NV_pixel_buffer_object GL_OES_depth_texture_cube_map GL_OES_required_internalformat GL_OES_surfaceless_context GL_EXT_color_buffer_float GL_EXT_debug_label GL_EXT_sRGB_write_control GL_EXT_separate_shader_objects GL_EXT_shader_implicit_conversions GL_EXT_shader_integer_mix GL_EXT_base_instance GL_EXT_compressed_ETC1_RGB8_sub_texture GL_EXT_copy_image GL_EXT_draw_buffers_indexed GL_EXT_draw_elements_base_vertex GL_EXT_multi_draw_indirect GL_EXT_polygon_offset_clamp GL_EXT_primitive_bounding_box GL_EXT_shader_io_blocks GL_EXT_texture_border_clamp GL_EXT_texture_cube_map_array GL_EXT_texture_view GL_KHR_context_flush_control GL_NV_image_formats GL_NV_shader_noperspective_interpolation GL_OES_copy_image GL_OES_draw_buffers_indexed GL_OES_draw_elements_base_vertex GL_OES_primitive_bounding_box GL_OES_shader_io_blocks GL_OES_texture_border_clamp GL_OES_texture_cube_map_array GL_OES_texture_stencil8 GL_OES_texture_storage_multisample_2d_array GL_OES_texture_view GL_EXT_buffer_storage GL_EXT_geometry_point_size GL_EXT_geometry_shader GL_KHR_no_error GL_KHR_texture_compression_astc_sliced_3d GL_OES_EGL_image_external_essl3 GL_OES_geometry_point_size GL_OES_geometry_shader GL_OES_shader_image_atomic GL_EXT_clear_texture GL_EXT_conservative_depth GL_EXT_disjoint_timer_query GL_EXT_texture_compression_s3tc_srgb GL_MESA_shader_integer_functions GL_EXT_color_buffer_half_float GL_EXT_texture_mirror_clamp_to_edge GL_KHR_parallel_shader_compile GL_EXT_EGL_image_storage GL_MESA_framebuffer_flip_y GL_EXT_texture_query_lod GL_MESA_sampler_objects GL_EXT_EGL_image_storage_compression GL_EXT_texture_storage_compression GL_MESA_bgra 
00:00:00.162 [util/env.c:9] Loading WLR_SCENE_DISABLE_DIRECT_SCANOUT option: 1
00:00:00.162 [wayland] unable to lock lockfile /run/user/1000/wayland-0.lock, maybe another compositor is running
00:00:00.163 [backend/wayland/backend.c:450] Starting Wayland backend
00:00:00.183 [../livi-compositor.c:1464] livi: new output -> screen 'main' at x=0 (1280x752)
00:00:00.224 [../livi-compositor.c:2084] livi: control socket at /run/user/1000/livi-compositor.ctrl
00:00:00.226 [../livi-compositor.c:2260] Running livi-compositor on WAYLAND_DISPLAY=wayland-1
[19:56:06.488] [GstVideo] GStreamer 1.26.2
[19:56:06.495] [CodecCapability] GStreamer codecs: h264(hw=true sw=true) h265(hw=true sw=true) vp9(hw=false sw=true) av1(hw=false sw=false)
[19:56:06.495] [CodecCapability] hevc support: true
[2315:0716/195606.700154:ERROR:media/gpu/vaapi/vaapi_wrapper.cc:1796] vaInitialize failed: unknown libva error
[2315:0716/195606.707041:ERROR:ui/ozone/platform/wayland/gpu/wayland_surface_factory.cc:249] '--ozone-platform=wayland' is not compatible with Vulkan. Consider switching to '--ozone-platform=x11' or disabling Vulkan
00:00:03.352 [../livi-compositor.c:1622] livi: app_id='dev.f-io.livi' title='LIVI' tag='' -> ui on screen 'main'
[19:56:07.115] [TelemetrySocket] Server listening on port 4000
00:00:03.759 [../livi-compositor.c:1622] livi: app_id='livi' title='USB Permission Update' tag='' -> dialog on screen 'main'
[19:56:07.259] [USBService] startup scan: 3 USB devices on bus: vid=0x320f pid=0x5044 cls=0x0, vid=0x2109 pid=0x3431 cls=0x9, vid=0x46d pid=0xc092 cls=0x0
[2266:0716/195610.207904:ERROR:content/browser/browser_main_loop.cc:274] GLib-GObject: ../../../gobject/gsignal.c:2699: instance '0x24003543c0' has no handler with id '1410'
00:00:09.921 [../livi-compositor.c:1622] livi: app_id='livi' title='Done' tag='' -> dialog on screen 'main'
[2266:0716/195623.332133:ERROR:content/browser/browser_main_loop.cc:274] GLib-GObject: ../../../gobject/gsignal.c:2699: instance '0x24003543c0' has no handler with id '4825'
[19:56:23.364] [USB] Graceful disconnect: stopping projection
[19:56:23.923] [TelemetrySocket] HTTP server closed
[19:56:23.924] [TelemetrySocket] IO closed
00:00:20.566 [../livi-compositor.c:1886] livi: restart requested -> waiting for inner UI to quit, then re-exec
00:00:20.701 [../livi-compositor.c:1671] livi: main UI toplevel gone -> shutting down
00:00:20.707 [../livi-compositor.c:2267] livi: re-exec for full restart
00:00:00.000 [backend/wayland/backend.c:587] Creating wayland backend
00:00:00.106 [render/egl.c:205] Supported EGL client extensions: EGL_EXT_device_base EGL_EXT_device_enumeration EGL_EXT_device_query EGL_EXT_platform_base EGL_KHR_client_get_all_proc_addresses EGL_EXT_client_extensions EGL_KHR_debug EGL_EXT_platform_device EGL_EXT_explicit_device EGL_EXT_platform_wayland EGL_KHR_platform_wayland EGL_EXT_platform_x11 EGL_KHR_platform_x11 EGL_EXT_platform_xcb EGL_MESA_platform_gbm EGL_KHR_platform_gbm EGL_MESA_platform_surfaceless
00:00:00.150 [render/egl.c:369] Using EGL 1.5
00:00:00.150 [render/egl.c:370] Supported EGL display extensions: EGL_ANDROID_blob_cache EGL_ANDROID_native_fence_sync EGL_EXT_buffer_age EGL_EXT_config_select_group EGL_EXT_image_dma_buf_import EGL_EXT_image_dma_buf_import_modifiers EGL_EXT_surface_compression EGL_KHR_cl_event2 EGL_KHR_config_attribs EGL_KHR_context_flush_control EGL_KHR_create_context EGL_KHR_create_context_no_error EGL_KHR_fence_sync EGL_KHR_get_all_proc_addresses EGL_KHR_gl_colorspace EGL_KHR_gl_renderbuffer_image EGL_KHR_gl_texture_2D_image EGL_KHR_gl_texture_3D_image EGL_KHR_gl_texture_cubemap_image EGL_KHR_image EGL_KHR_image_base EGL_KHR_image_pixmap EGL_KHR_no_config_context EGL_KHR_reusable_sync EGL_KHR_surfaceless_context EGL_EXT_pixel_format_float EGL_KHR_wait_sync EGL_MESA_configless_context EGL_MESA_drm_image EGL_MESA_gl_interop EGL_MESA_image_dma_buf_export EGL_MESA_query_driver EGL_MESA_x11_native_visual_id EGL_WL_bind_wayland_display 
00:00:00.150 [render/egl.c:372] Supported EGL device extensions: EGL_EXT_device_drm EGL_EXT_device_drm_render_node
00:00:00.150 [render/egl.c:374] EGL vendor: Mesa Project
00:00:00.160 [render/gles2/renderer.c:538] Creating GLES2 renderer
00:00:00.160 [render/gles2/renderer.c:539] Using OpenGL ES 3.1 Mesa 25.0.7-2+rpt4
00:00:00.160 [render/gles2/renderer.c:540] GL vendor: Broadcom
00:00:00.160 [render/gles2/renderer.c:541] GL renderer: V3D 4.2.14.0
00:00:00.160 [render/gles2/renderer.c:542] Supported GLES2 extensions: GL_EXT_blend_minmax GL_EXT_multi_draw_arrays GL_EXT_texture_filter_anisotropic GL_EXT_texture_compression_s3tc GL_EXT_texture_compression_dxt1 GL_EXT_texture_compression_rgtc GL_EXT_texture_format_BGRA8888 GL_OES_compressed_ETC1_RGB8_texture GL_OES_depth24 GL_OES_element_index_uint GL_OES_fbo_render_mipmap GL_OES_mapbuffer GL_OES_rgb8_rgba8 GL_OES_standard_derivatives GL_OES_stencil8 GL_OES_texture_3D GL_OES_texture_float GL_OES_texture_half_float GL_OES_texture_half_float_linear GL_OES_texture_npot GL_OES_vertex_half_float GL_EXT_draw_instanced GL_EXT_texture_sRGB_decode GL_OES_EGL_image GL_OES_depth_texture GL_AMD_performance_monitor GL_OES_packed_depth_stencil GL_EXT_texture_type_2_10_10_10_REV GL_NV_conditional_render GL_OES_get_program_binary GL_APPLE_texture_max_level GL_EXT_discard_framebuffer GL_EXT_read_format_bgra GL_EXT_texture_storage GL_NV_pack_subimage GL_NV_texture_barrier GL_EXT_frag_depth GL_NV_fbo_color_attachments GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_vertex_array_object GL_ANGLE_pack_reverse_row_order GL_ANGLE_texture_compression_dxt3 GL_ANGLE_texture_compression_dxt5 GL_EXT_occlusion_query_boolean GL_EXT_texture_rg GL_EXT_unpack_subimage GL_NV_draw_buffers GL_NV_read_buffer GL_NV_read_depth GL_NV_read_depth_stencil GL_NV_read_stencil GL_APPLE_sync GL_EXT_draw_buffers GL_EXT_instanced_arrays GL_EXT_map_buffer_range GL_EXT_shadow_samplers GL_KHR_debug GL_KHR_texture_compression_astc_ldr GL_NV_generate_mipmap_sRGB GL_NV_pixel_buffer_object GL_OES_depth_texture_cube_map GL_OES_required_internalformat GL_OES_surfaceless_context GL_EXT_color_buffer_float GL_EXT_debug_label GL_EXT_sRGB_write_control GL_EXT_separate_shader_objects GL_EXT_shader_implicit_conversions GL_EXT_shader_integer_mix GL_EXT_base_instance GL_EXT_compressed_ETC1_RGB8_sub_texture GL_EXT_copy_image GL_EXT_draw_buffers_indexed GL_EXT_draw_elements_base_vertex GL_EXT_multi_draw_indirect GL_EXT_polygon_offset_clamp GL_EXT_primitive_bounding_box GL_EXT_shader_io_blocks GL_EXT_texture_border_clamp GL_EXT_texture_cube_map_array GL_EXT_texture_view GL_KHR_context_flush_control GL_NV_image_formats GL_NV_shader_noperspective_interpolation GL_OES_copy_image GL_OES_draw_buffers_indexed GL_OES_draw_elements_base_vertex GL_OES_primitive_bounding_box GL_OES_shader_io_blocks GL_OES_texture_border_clamp GL_OES_texture_cube_map_array GL_OES_texture_stencil8 GL_OES_texture_storage_multisample_2d_array GL_OES_texture_view GL_EXT_buffer_storage GL_EXT_geometry_point_size GL_EXT_geometry_shader GL_KHR_no_error GL_KHR_texture_compression_astc_sliced_3d GL_OES_EGL_image_external_essl3 GL_OES_geometry_point_size GL_OES_geometry_shader GL_OES_shader_image_atomic GL_EXT_clear_texture GL_EXT_conservative_depth GL_EXT_disjoint_timer_query GL_EXT_texture_compression_s3tc_srgb GL_MESA_shader_integer_functions GL_EXT_color_buffer_half_float GL_EXT_texture_mirror_clamp_to_edge GL_KHR_parallel_shader_compile GL_EXT_EGL_image_storage GL_MESA_framebuffer_flip_y GL_EXT_texture_query_lod GL_MESA_sampler_objects GL_EXT_EGL_image_storage_compression GL_EXT_texture_storage_compression GL_MESA_bgra 
00:00:00.213 [util/env.c:9] Loading WLR_SCENE_DISABLE_DIRECT_SCANOUT option: 1
00:00:00.213 [wayland] unable to lock lockfile /run/user/1000/wayland-0.lock, maybe another compositor is running
00:00:00.213 [backend/wayland/backend.c:450] Starting Wayland backend
00:00:00.230 [../livi-compositor.c:1464] livi: new output -> screen 'main' at x=0 (1280x752)
00:00:00.253 [../livi-compositor.c:2084] livi: control socket at /run/user/1000/livi-compositor.ctrl
00:00:00.255 [../livi-compositor.c:2260] Running livi-compositor on WAYLAND_DISPLAY=wayland-1
[2568:0716/195627.422989:ERROR:media/gpu/vaapi/vaapi_wrapper.cc:1796] vaInitialize failed: unknown libva error
[2568:0716/195627.430684:ERROR:ui/ozone/platform/wayland/gpu/wayland_surface_factory.cc:249] '--ozone-platform=wayland' is not compatible with Vulkan. Consider switching to '--ozone-platform=x11' or disabling Vulkan
[19:56:29.257] [GstVideo] GStreamer 1.26.2
[19:56:29.261] [CodecCapability] GStreamer codecs: h264(hw=true sw=true) h265(hw=true sw=true) vp9(hw=false sw=true) av1(hw=false sw=false)
[19:56:29.262] [CodecCapability] hevc support: true
00:00:05.275 [../livi-compositor.c:1622] livi: app_id='dev.f-io.livi' title='LIVI' tag='' -> ui on screen 'main'
[19:56:29.745] [TelemetrySocket] Server listening on port 4000
00:00:05.618 [../livi-compositor.c:1622] livi: app_id='livi' title='Wireless Projection — Permission Required' tag='' -> dialog on screen 'main'
[19:56:29.892] [USBService] startup scan: 3 USB devices on bus: vid=0x320f pid=0x5044 cls=0x0, vid=0x2109 pid=0x3431 cls=0x9, vid=0x46d pid=0xc092 cls=0x0
[2518:0716/195634.403146:ERROR:content/browser/browser_main_loop.cc:274] GLib-GObject: ../../../gobject/gsignal.c:2699: instance '0x2c003591c0' has no handler with id '1408'
00:00:14.829 [../livi-compositor.c:1622] livi: app_id='livi' title='Done' tag='' -> dialog on screen 'main'
[2518:0716/195640.228054:ERROR:content/browser/browser_main_loop.cc:274] GLib-GObject: ../../../gobject/gsignal.c:2699: instance '0x2c00358b40' has no handler with id '4822'
00:00:16.459 [../livi-compositor.c:1622] livi: app_id='livi' title='LIVI — Permission Required' tag='' -> dialog on screen 'main'
[2518:0716/195646.871434:ERROR:content/browser/browser_main_loop.cc:274] GLib-GObject: ../../../gobject/gsignal.c:2699: instance '0x2c00358b40' has no handler with id '5089'
[19:56:52.818] [ProjectionService] starting unified BT supervisor (aaWireless=true cpWireless=false)
[19:56:52.964] [AaManager] wireless AA listening on TCP 5277
[19:56:52.965] [CpManager] listening on :7000 (dual-stack)
[19:56:53.385] [helper] [config] loaded from /home/milan/.config/LIVI/config.json
[19:56:53.548] [helper!] Traceback (most recent call last):
[19:56:53.550] [helper!]   File "/home/milan/.config/LIVI/driver/unified/helper/livi-helper.py", line 475, in <module>
[19:56:53.551] [helper!]     main()
[19:56:53.552] [helper!]     ~~~~^^
[19:56:53.553] [helper!]   File "/home/milan/.config/LIVI/driver/unified/helper/livi-helper.py", line 274, in main
[19:56:53.553] [helper!]     from bt import cp_handler
[19:56:53.553] [helper!]   File "/home/milan/.config/LIVI/driver/unified/bt/cp_handler.py", line 22, in <module>
[19:56:53.554] [helper!]     import iap2.carplay_bonjour as carplay_bonjour
[19:56:53.554] [helper!]   File "/home/milan/.config/LIVI/driver/unified/cp/iap2/carplay_bonjour.py", line 6, in <module>
[19:56:53.554] [helper!]     import avahi
[19:56:53.555] [helper!] ModuleNotFoundError: No module named 'avahi'
[19:56:55.985] [helper] [config] loaded from /home/milan/.config/LIVI/config.json
[19:56:56.105] [helper!] Traceback (most recent call last):
[19:56:56.106] [helper!]   File "/home/milan/.config/LIVI/driver/unified/helper/livi-helper.py", line 475, in <module>
[19:56:56.107] [helper!]     main()
[19:56:56.107] [helper!]     ~~~~^^
[19:56:56.107] [helper!]   File "/home/milan/.config/LIVI/driver/unified/helper/livi-helper.py", line 274, in main
[19:56:56.107] [helper!]     from bt import cp_handler
[19:56:56.107] [helper!]   File "/home/milan/.config/LIVI/driver/unified/bt/cp_handler.py", line 22, in <module>
[19:56:56.107] [helper!]     import iap2.carplay_bonjour as carplay_bonjour
[19:56:56.108] [helper!]   File "/home/milan/.config/LIVI/driver/unified/cp/iap2/carplay_bonjour.py", line 6, in <module>
[19:56:56.108] [helper!]     import avahi
[19:56:56.108] [helper!] ModuleNotFoundError: No module named 'avahi'
[19:56:58.591] [helper] [config] loaded from /home/milan/.config/LIVI/config.json
[19:56:58.718] [helper!] Traceback (most recent call last):
[19:56:58.719] [helper!]   File "/home/milan/.config/LIVI/driver/unified/helper/livi-helper.py", line 475, in <module>
[19:56:58.720] [helper!]     main()
[19:56:58.720] [helper!]     ~~~~^^
[19:56:58.720] [helper!]   File "/home/milan/.config/LIVI/driver/unified/helper/livi-helper.py", line 274, in main
[19:56:58.720] [helper!]     from bt import cp_handler
[19:56:58.720] [helper!]   File "/home/milan/.config/LIVI/driver/unified/bt/cp_handler.py", line 22, in <module>
[19:56:58.720] [helper!]     import iap2.carplay_bonjour as carplay_bonjour
[19:56:58.720] [helper!]   File "/home/milan/.config/LIVI/driver/unified/cp/iap2/carplay_bonjour.py", line 6, in <module>
[19:56:58.720] [helper!]     import avahi
[19:56:58.721] [helper!] ModuleNotFoundError: No module named 'avahi'
[19:57:01.149] [helper] [config] loaded from /home/milan/.config/LIVI/config.json
[19:57:01.278] [helper!] Traceback (most recent call last):
[19:57:01.279] [helper!]   File "/home/milan/.config/LIVI/driver/unified/helper/livi-helper.py", line 475, in <module>
[19:57:01.279] [helper!]     main()
[19:57:01.280] [helper!]     ~~~~^^
[19:57:01.280] [helper!]   File "/home/milan/.config/LIVI/driver/unified/helper/livi-helper.py", line 274, in main
[19:57:01.280] [helper!]     from bt import cp_handler
[19:57:01.280] [helper!]   File "/home/milan/.config/LIVI/driver/unified/bt/cp_handler.py", line 22, in <module>
[19:57:01.280] [helper!]     import iap2.carplay_bonjour as carplay_bonjour
[19:57:01.280] [helper!]   File "/home/milan/.config/LIVI/driver/unified/cp/iap2/carplay_bonjour.py", line 6, in <module>
[19:57:01.280] [helper!]     import avahi
[19:57:01.280] [helper!] ModuleNotFoundError: No module named 'avahi'
[19:57:02.444] [USBService] attach vid=0x4e8 pid=0x6860 cls=0x0 → dongle=false accessory=false phoneCandidate=true lastPhone=false
[19:57:02.454] [USBService] phone candidate detected — kicking off wired bring-up vid=0x4e8 pid=0x6860
[19:57:02.455] [TransportArbiter] wired phone marked connected
[19:57:02.467] [ProjectionService] wired AA bring-up with device vid=0x4e8 pid=0x6860
[19:57:02.469] [AaManager] _startWiredBridge: bringing up wired AOAP bridge
[19:57:02.470] [UsbAoapBridge] switchAndOpen isAccessoryMode=false vid=0x4e8 pid=0x6860
[19:57:02.474] [USBService] attach vid=0x4e8 pid=0x6860 cls=0x0 → dongle=false accessory=false phoneCandidate=true lastPhone=true
[19:57:02.478] [USBService] OEM-PID phone re-attach while lastPhone=true — assuming stale state, resetting
[19:57:02.479] [USBService] phone candidate detected — kicking off wired bring-up vid=0x4e8 pid=0x6860
[19:57:02.480] [TransportArbiter] wired phone re-attach during detach debounce — committing detach inline
[19:57:02.480] [TransportArbiter] wired phone marked connected
[19:57:02.484] [UsbAoapBridge] AOAP handshake starting
[19:57:02.513] [UsbAoapBridge] AOAP handshake sent — awaiting accessory re-enumeration
[19:57:02.649] [USBService] Phone detach during re-enumeration window — suppressed
[19:57:03.471] [USBService] attach vid=0x18d1 pid=0x2d01 cls=0x0 → dongle=false accessory=true phoneCandidate=true lastPhone=true
[19:57:03.472] [USBService] Accessory-mode re-attach during re-enumeration window — bridge owns it (suspend)
[19:57:03.478] [UsbAoapBridge] accessory re-enumerated — opening
[19:57:03.481] [USBService] attach vid=0x18d1 pid=0x2d01 cls=0x0 → dongle=false accessory=true phoneCandidate=true lastPhone=true
[19:57:03.482] [USBService] Accessory-mode re-attach during re-enumeration window — bridge owns it (suspend)
[19:57:03.491] [AaManager] wired bridge ready on 127.0.0.1:5278, dialling loopback
[19:57:03.493] [AaManager] wired AA bridge started on loopback
[19:57:03.494] [ProjectionService] started in AA mode (wired)
[19:57:03.502] [AaManager] wired loopback connected → spawning AaSession
[19:57:03.506] [AaSession] display 1280×720 (AR 1.778) → AA tier 1280×720 (AR 1.778) @180dpi, PAR e4=10000
[19:57:03.507] [AaSession] clusterDisplayed=true (screens=[main]; channel will be advertised in SDR)
[19:57:03.507] [AaSession] cluster 1280×720 (AR 1.778) → AA tier 1280×720 (AR 1.778) @180dpi, PAR e4=10000
[19:57:03.551] [hwaddr] BT MAC detected from busctl: E4:5F:01:FF:DD:DC (hci0)
[19:57:03.553] [hwaddr] WiFi BSSID detected: E4:5F:01:FF:DD:DA (wlan0)
[19:57:03.556] [AaSession] display 1280×720 (AR 1.778) → AA tier 1280×720 (AR 1.778) @180dpi, PAR e4=10000
[19:57:03.557] [AaSession] clusterDisplayed=true (screens=[main]; channel will be advertised in SDR)
[19:57:03.557] [AaSession] cluster 1280×720 (AR 1.778) → AA tier 1280×720 (AR 1.778) @180dpi, PAR e4=10000
[19:57:03.826] [ControlChannel] ServiceDiscoveryRequest device_name="Android" brand="samsung SM-N970F" phone_info={"instanceId":"[removed]"}
[19:57:03.833] ══════ SESSIONS · create #1 androidauto in={"instanceId":"[removed]","ip":"127.0.0.1"} ══════
  #1  androidauto usb  held   main:- cluster:-         keys: inst=[removed] ip=127.0.0.1
[19:57:03.837] [ProjectionService] active session -> #1 androidauto
[19:57:03.842] [SESSIONS] codec-restore #1 androidauto: session=- map=- → gstVideoCodec=h264
[19:57:03.844] ══════ SESSIONS · activate #1 androidauto (prev none) ══════
  #1  androidauto usb  ACTIVE main:- cluster:-         keys: inst=[removed] ip=127.0.0.1
[19:57:03.939] [helper] [config] loaded from /home/milan/.config/LIVI/config.json
[19:57:04.032] [ControlChannel] AudioFocusRequest raw: 0804
[19:57:04.033] [ControlChannel] AudioFocus type=4(RELEASE) → state=3(LOSS)
[19:57:04.086] [helper!] Traceback (most recent call last):
[19:57:04.087] [helper!]   File "/home/milan/.config/LIVI/driver/unified/helper/livi-helper.py", line 475, in <module>
[19:57:04.088] [helper!]     main()
[19:57:04.089] [helper!]     ~~~~^^
[19:57:04.090] [helper!]   File "/home/milan/.config/LIVI/driver/unified/helper/livi-helper.py", line 274, in main
[19:57:04.091] [helper!]     from bt import cp_handler
[19:57:04.092] [helper!]   File "/home/milan/.config/LIVI/driver/unified/bt/cp_handler.py", line 22, in <module>
[19:57:04.093] [helper!]     import iap2.carplay_bonjour as carplay_bonjour
[19:57:04.094] [helper!]   File "/home/milan/.config/LIVI/driver/unified/cp/iap2/carplay_bonjour.py", line 6, in <module>
[19:57:04.095] [helper!]     import avahi
[19:57:04.096] [helper!] ModuleNotFoundError: No module named 'avahi'
[19:57:04.116] [AudioChannel:media] setup codec=1 48000Hz 2ch
[19:57:04.160] [AudioChannel:speech] setup codec=1 16000Hz 1ch
[19:57:04.163] [AudioChannel:phone] setup codec=1 16000Hz 1ch
[19:57:04.176] [AaEventBridge] video-codec=h265 (phone selection)
[19:57:04.178] ══════ SESSIONS · video-codec h265 → stored on #1 ══════
  #1  androidauto usb  ACTIVE main:h265 cluster:-      keys: inst=[removed] ip=127.0.0.1
[19:57:04.180] [Session] ★ phone picked video codec: H265 (offered: h264, h265)
[19:57:04.181] [AaEventBridge] AAStack connected
[19:57:04.185] ══════ SESSIONS · upsert #1 androidauto in={} ══════
  #1  androidauto usb  ACTIVE main:h265 cluster:-      keys: inst=[removed] ip=127.0.0.1
[19:57:06.615] [helper] [config] loaded from /home/milan/.config/LIVI/config.json
[19:57:06.794] [helper!] Traceback (most recent call last):
[19:57:06.796] [helper!]   File "/home/milan/.config/LIVI/driver/unified/helper/livi-helper.py", line 475, in <module>
[19:57:06.796] [helper!]     main()
[19:57:06.796] [helper!]     ~~~~^^
[19:57:06.796] [helper!]   File "/home/milan/.config/LIVI/driver/unified/helper/livi-helper.py", line 274, in main
[19:57:06.797] [helper!]     from bt import cp_handler
[19:57:06.797] [helper!]   File "/home/milan/.config/LIVI/driver/unified/bt/cp_handler.py", line 22, in <module>
[19:57:06.797] [helper!]     import iap2.carplay_bonjour as carplay_bonjour
[19:57:06.797] [helper!]   File "/home/milan/.config/LIVI/driver/unified/cp/iap2/carplay_bonjour.py", line 6, in <module>
[19:57:06.797] [helper!]     import avahi
[19:57:06.797] [helper!] ModuleNotFoundError: No module named 'avahi'
[19:57:06.912] [bt] supervisor error: livi-helper.py exceeded max restarts (5)
[19:57:09.437] [AaManager] wired bridge error: transferOut error: Cancelled
[19:57:09.439] [AaManager] wired bridge error: transferOut error: Cancelled
[19:57:22.999] [ProjectionService] aa-bt initial populate gave up after 30s — paired-device list may be empty until the next user action triggers a refresh
[19:57:23.003] [ProjectionService] autoconnect: skipped (wired AA session active)
milan@raspberrypi:~ $ [19:58:18.690] [USBService] Phone disconnected
[19:58:19.694] [TransportArbiter] wired phone marked disconnected
[19:58:19.708] ══════ SESSIONS · close #1/androidauto → IDLE ══════
  (no sessions)
[19:58:19.735] [AaManager] wired loopback socket error: write EPIPE
[19:58:19.737] [Session loopback] error: write EPIPE
[19:58:19.738] [AaEventBridge] suppressed AAStack error during close: write EPIPE
[19:58:19.740] [Session loopback] disconnected: write EPIPE
[19:58:19.741] [AaEventBridge] AAStack disconnected (write EPIPE) — supervisor stays up for retry
[19:58:19.749] [Session loopback] disconnected: socket closed
[19:58:19.749] [AaEventBridge] AAStack disconnected (socket closed) — supervisor stays up for retry
[19:58:20.749] [Session] shutdown fallback timeout (no ByeByeResponse)
[19:58:20.749] [Session loopback] disconnected: hu-initiated shutdown
[19:58:20.749] [AaEventBridge] AAStack disconnected (hu-initiated shutdown) — supervisor stays up for retry
[19:58:20.803] [UsbAoapBridge] device reset failed: Error: reset error: device disconnected (errno 19)
[19:58:20.804] [UsbAoapBridge] accessory device closed
[19:58:20.804] [AaManager] wired bridge closed
[19:58:24.104] [USBService] attach vid=0x4e8 pid=0x6860 cls=0x0 → dongle=false accessory=false phoneCandidate=true lastPhone=false
[19:58:24.109] [USBService] phone candidate detected — kicking off wired bring-up vid=0x4e8 pid=0x6860
[19:58:24.110] [TransportArbiter] wired phone marked connected
[19:58:24.120] [ProjectionService] wired AA bring-up with device vid=0x4e8 pid=0x6860
[19:58:24.120] [AaManager] _startWiredBridge: bringing up wired AOAP bridge
[19:58:24.122] [UsbAoapBridge] switchAndOpen isAccessoryMode=false vid=0x4e8 pid=0x6860
[19:58:24.127] [USBService] attach vid=0x4e8 pid=0x6860 cls=0x0 → dongle=false accessory=false phoneCandidate=true lastPhone=true
[19:58:24.135] [USBService] OEM-PID phone re-attach while lastPhone=true — assuming stale state, resetting
[19:58:24.136] [USBService] phone candidate detected — kicking off wired bring-up vid=0x4e8 pid=0x6860
[19:58:24.136] [TransportArbiter] wired phone re-attach during detach debounce — committing detach inline
[19:58:24.136] [TransportArbiter] wired phone marked connected
[19:58:24.140] [UsbAoapBridge] AOAP handshake starting
[19:58:24.171] [UsbAoapBridge] AOAP handshake sent — awaiting accessory re-enumeration
[19:58:24.324] [USBService] Phone detach during re-enumeration window — suppressed
[19:58:24.883] [USBService] attach vid=0x18d1 pid=0x2d01 cls=0x0 → dongle=false accessory=true phoneCandidate=true lastPhone=true
[19:58:24.884] [USBService] Accessory-mode re-attach during re-enumeration window — bridge owns it (suspend)
[19:58:24.890] [UsbAoapBridge] accessory re-enumerated — opening
[19:58:24.896] [USBService] attach vid=0x18d1 pid=0x2d01 cls=0x0 → dongle=false accessory=true phoneCandidate=true lastPhone=true
[19:58:24.897] [USBService] Accessory-mode re-attach during re-enumeration window — bridge owns it (suspend)
[19:58:24.909] [AaManager] wired bridge ready on 127.0.0.1:5278, dialling loopback
[19:58:24.910] [AaManager] wired AA bridge started on loopback
[19:58:24.911] [ProjectionService] started in AA mode (wired)
[19:58:24.916] [AaManager] wired loopback connected → spawning AaSession
[19:58:24.917] [AaSession] display 1280×720 (AR 1.778) → AA tier 1280×720 (AR 1.778) @180dpi, PAR e4=10000
[19:58:24.918] [AaSession] clusterDisplayed=true (screens=[main]; channel will be advertised in SDR)
[19:58:24.918] [AaSession] cluster 1280×720 (AR 1.778) → AA tier 1280×720 (AR 1.778) @180dpi, PAR e4=10000
[19:58:24.981] [hwaddr] BT MAC detected from busctl: E4:5F:01:FF:DD:DC (hci0)
[19:58:24.982] [hwaddr] WiFi BSSID detected: E4:5F:01:FF:DD:DA (wlan0)
[19:58:24.983] [AaSession] display 1280×720 (AR 1.778) → AA tier 1280×720 (AR 1.778) @180dpi, PAR e4=10000
[19:58:24.984] [AaSession] clusterDisplayed=true (screens=[main]; channel will be advertised in SDR)
[19:58:24.984] [AaSession] cluster 1280×720 (AR 1.778) → AA tier 1280×720 (AR 1.778) @180dpi, PAR e4=10000
[19:58:25.075] [ControlChannel] ServiceDiscoveryRequest device_name="Android" brand="samsung SM-N970F" phone_info={"instanceId":"[removed]"}
[19:58:25.076] ══════ SESSIONS · create #2 androidauto in={"instanceId":"[removed]","ip":"127.0.0.1"} ══════
  #2  androidauto usb  held   main:- cluster:-         keys: inst=[removed] ip=127.0.0.1
[19:58:25.077] [ProjectionService] active session -> #2 androidauto
[19:58:25.079] [SESSIONS] codec-restore #2 androidauto: session=- map=- → gstVideoCodec=h264
[19:58:25.080] ══════ SESSIONS · activate #2 androidauto (prev none) ══════
  #2  androidauto usb  ACTIVE main:- cluster:-         keys: inst=[removed] ip=127.0.0.1
[19:58:25.153] [ControlChannel] AudioFocusRequest raw: 0804
[19:58:25.154] [ControlChannel] AudioFocus type=4(RELEASE) → state=3(LOSS)
[19:58:25.211] [AudioChannel:media] setup codec=1 48000Hz 2ch
[19:58:25.231] [AudioChannel:speech] setup codec=1 16000Hz 1ch
[19:58:25.238] [AudioChannel:phone] setup codec=1 16000Hz 1ch
[19:58:25.247] [AaEventBridge] video-codec=h265 (phone selection)
[19:58:25.249] ══════ SESSIONS · video-codec h265 → stored on #2 ══════
  #2  androidauto usb  ACTIVE main:h265 cluster:-      keys: inst=[removed] ip=127.0.0.1
[19:58:25.251] [Session] ★ phone picked video codec: H265 (offered: h264, h265)
[19:58:25.252] [AaEventBridge] AAStack connected
[19:58:25.256] ══════ SESSIONS · upsert #2 androidauto in={} ══════
  #2  androidauto usb  ACTIVE main:h265 cluster:-      keys: inst=[removed] ip=127.0.0.1
[19:58:29.087] [AaManager] wired bridge error: transferOut error: Cancelled
[19:58:29.088] [AaManager] wired bridge error: transferOut error: Cancelled
^C
milan@raspberrypi:~ $ 

[f-io]

Two separate things in this log. ModuleNotFoundError: No module named avahi crashes the helper.
That breaks wireless AA and BT device management, but not the wired session (I will harden the helper for that one).

Fix: sudo apt install python3-avahi

The actual connection drop is separate: the wired AA session comes up fully (codec H265 negotiated, audio set up) and then dies ~5s later on transferOut error: Cancelled, independent of the helper. That's the real bug here.

Please install avahi to clear the helper spam, but expect the connection to still drop, that part we're still tracking. Could you retest and confirm the transferOut Cancelled still happens after installing avahi?

And please make sure that you allow USB data transfer on the USB connection.

[MilanBabuljak]

Hi, I did install avahi, but it didnt help. I verified that I am on Data / Android Auto mode on the phone. What is interesting is that AA works normally on different phone, an A53 5G. So this is issue related only to the Note10. However Note10 can connect to Kia infotainment and can work there over AA.

[f-io]

Select nightly on the installer.

curl -fL -o install.sh https://raw.githubusercontent.com/f-io/LIVI/main/scripts/install/desktop/install.sh
chmod +x install.sh
./install.sh

If this does not solve your issue, feel free to open this ticket again.