Aug 25 08:21:01 primo-jarrie go-librespot[4297]: time="2026-08-25T08:21:01+02:00" level=trace msg="received accesspoint ping" Aug 25 08:21:01 primo-jarrie go-librespot[4297]: time="2026-08-25T08:21:01+02:00" level=trace msg="received accesspoint pong ack" Aug 25 08:21:06 primo-jarrie bluealsa[3394]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_5D_DF_E9_6B_3B_42/mcp/player0, ...) Aug 25 08:21:06 primo-jarrie volumio[3834]: ------------------------------------ BT MESSAGE: [_watchMediaPlayer] Binding player for path: /org/bluez/hci0/dev_5D_DF_E9_6B_3B_42/mcp/player0 mac: 5D:DF:E9:6B:3B:42 Aug 25 08:21:06 primo-jarrie volumio[3834]: ------------------------------------ BT MESSAGE: activePlayer bound: /org/bluez/hci0/dev_5D_DF_E9_6B_3B_42/mcp/player0 Aug 25 08:21:06 primo-jarrie dbus-daemon[2955]: [system] Connection ":1.117" is not allowed to add more match rules (increase limits in configuration file if required; max_match_rules_per_connection=512) Aug 25 08:21:07 primo-jarrie volumio[3834]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 08:21:07 primo-jarrie volumio[3834]: DBusError: Connection ":1.117" is not allowed to add more match rules (increase limits in configuration file if required; max_match_rules_per_connection=512) Aug 25 08:21:07 primo-jarrie volumio[3834]: at _methodReturnHandlers. (/volumio/app/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/bus.js:343:27) Aug 25 08:21:07 primo-jarrie volumio[3834]: at handleMessage (/volumio/app/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/bus.js:101:11) Aug 25 08:21:07 primo-jarrie volumio[3834]: at EventEmitter. (/volumio/app/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/bus.js:151:9) Aug 25 08:21:07 primo-jarrie volumio[3834]: at EventEmitter.emit (node:events:514:28) Aug 25 08:21:07 primo-jarrie volumio[3834]: at /volumio/app/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/connection.js:132:14 Aug 25 08:21:07 primo-jarrie volumio[3834]: at Socket. (/volumio/app/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/message.js:65:9) Aug 25 08:21:07 primo-jarrie volumio[3834]: at Socket.emit (node:events:514:28) Aug 25 08:21:07 primo-jarrie volumio[3834]: at emitReadable_ (node:internal/streams/readable:609:12) Aug 25 08:21:07 primo-jarrie volumio[3834]: at process.processTicksAndRejections (node:internal/process/task_queues:81:21) { Aug 25 08:21:07 primo-jarrie volumio[3834]: type: 'org.freedesktop.DBus.Error.LimitsExceeded', Aug 25 08:21:07 primo-jarrie volumio[3834]: text: 'Connection ":1.117" is not allowed to add more match rules (increase limits in configuration file if required; max_match_rules_per_connection=512)', Aug 25 08:21:07 primo-jarrie volumio[3834]: reply: Message { Aug 25 08:21:07 primo-jarrie volumio[3834]: type: 3, Aug 25 08:21:07 primo-jarrie volumio[3834]: _sent: false, Aug 25 08:21:07 primo-jarrie volumio[3834]: _serial: 515, Aug 25 08:21:07 primo-jarrie volumio[3834]: path: undefined, Aug 25 08:21:07 primo-jarrie volumio[3834]: interface: undefined, Aug 25 08:21:07 primo-jarrie volumio[3834]: member: undefined, Aug 25 08:21:07 primo-jarrie volumio[3834]: errorName: 'org.freedesktop.DBus.Error.LimitsExceeded', Aug 25 08:21:07 primo-jarrie volumio[3834]: replySerial: 1537, Aug 25 08:21:07 primo-jarrie volumio[3834]: destination: ':1.117', Aug 25 08:21:07 primo-jarrie volumio[3834]: sender: 'org.freedesktop.DBus', Aug 25 08:21:07 primo-jarrie volumio[3834]: signature: 's', Aug 25 08:21:07 primo-jarrie volumio[3834]: body: [ Aug 25 08:21:07 primo-jarrie volumio[3834]: 'Connection ":1.117" is not allowed to add more match rules (increase limits in configuration file if required; max_match_rules_per_connection=512)' Aug 25 08:21:07 primo-jarrie volumio[3834]: ], Aug 25 08:21:07 primo-jarrie volumio[3834]: flags: 1 Aug 25 08:21:07 primo-jarrie volumio[3834]: } Aug 25 08:21:07 primo-jarrie volumio[3834]: } Aug 25 08:21:07 primo-jarrie volumio[3834]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 08:21:07 primo-jarrie sudo[13149]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-25 08:20' Aug 25 08:21:07 primo-jarrie sudo[13149]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:07 primo-jarrie sudo[13149]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:08 primo-jarrie volumio5-onboarding[4128]: time=2026-08-25T06:21:08.213Z level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Aug 25 08:21:08 primo-jarrie vtcs[4369]: [2026-08-25 08:21:08.217] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Aug 25 08:21:08 primo-jarrie volumio5-onboarding[4128]: time=2026-08-25T06:21:08.223Z level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:50628->127.0.0.1:3000: read: connection reset by peer" Aug 25 08:21:08 primo-jarrie systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 25 08:21:08 primo-jarrie volumio-remote-updater[2968]: [2026-08-25 06:21:08] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 25 08:21:08 primo-jarrie volumio-remote-updater[2968]: [2026-08-25 06:21:08] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 25 08:21:08 primo-jarrie go-librespot[4297]: time="2026-08-25T08:21:08+02:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Aug 25 08:21:08 primo-jarrie qobuz-connect[4265]: 20260825 08:21:08.218 [4265.4265] INFO SampleApp: Socket closed Aug 25 08:21:08 primo-jarrie bluealsa[3394]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_5D_DF_E9_6B_3B_42/mcp/player0, ...) Aug 25 08:21:08 primo-jarrie volumio5-onboarding[4128]: time=2026-08-25T06:21:08.275Z level=ERROR msg="failed to cancel pairing for disconnected device" component=ble/conn device=88:B9:51:EC:5F:7E error="Method \"CancelPairing\" with signature \"\" on interface \"org.bluez.Device1\" doesn't exist\n" Aug 25 08:21:08 primo-jarrie systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 25 08:21:08 primo-jarrie systemd[1]: Started dynamicswap.service - dynamicswap service. Aug 25 08:21:08 primo-jarrie systemd[1]: dynamicswap.service: Deactivated successfully. Aug 25 08:21:08 primo-jarrie systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Aug 25 08:21:08 primo-jarrie systemd[1]: Started dynamicswap.service - dynamicswap service. Aug 25 08:21:08 primo-jarrie systemd[1]: Stopped volumio.service - Volumio Backend Module. Aug 25 08:21:08 primo-jarrie systemd[1]: Started volumio.service - Volumio Backend Module. Aug 25 08:21:08 primo-jarrie systemd[1]: dynamicswap.service: Deactivated successfully. Aug 25 08:21:08 primo-jarrie bluealsa[3394]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_5D_DF_E9_6B_3B_42/mcp/player0, ...) Aug 25 08:21:09 primo-jarrie volumio5-onboarding[4128]: time=2026-08-25T06:21:09.226Z level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Aug 25 08:21:10 primo-jarrie volumio5-onboarding[4128]: time=2026-08-25T06:21:10.227Z level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Aug 25 08:21:11 primo-jarrie volumio[13171]: info: ------------------------------------------- Aug 25 08:21:11 primo-jarrie volumio[13171]: info: ----- Volumio3 ---- Aug 25 08:21:11 primo-jarrie volumio[13171]: info: ------------------------------------------- Aug 25 08:21:11 primo-jarrie volumio[13171]: info: ----- System startup ---- Aug 25 08:21:11 primo-jarrie volumio[13171]: info: ------------------------------------------- Aug 25 08:21:11 primo-jarrie volumio[13171]: info: MYVOLUMIO Environment detected Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Plugin folders cleanup Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Scanning into folder /volumio/app/plugins/ Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Scanning category audio_interface Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Scanning category miscellanea Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Scanning category music_service Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Scanning category plugins.json Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Scanning category system_controller Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Scanning category user_interface Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Scanning into folder /data/plugins/ Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Scanning category music_service Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Scanning category user_interface Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Plugin folders cleanup completed Aug 25 08:21:12 primo-jarrie volumio[13171]: info: ------------------------------------------- Aug 25 08:21:12 primo-jarrie volumio[13171]: info: ----- Core plugins startup ---- Aug 25 08:21:12 primo-jarrie volumio[13171]: info: ------------------------------------------- Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Loading plugins from folder /volumio/app/plugins/ Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Adding plugin bluetooth to MyMusic Plugins Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Adding plugin multiroom to MyMusic Plugins Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Adding plugin upnp to MyMusic Plugins Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Adding plugin metavolumio to MyMusic Plugins Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Adding plugin cd_controller to MyMusic Plugins Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Adding plugin qobuzconnect to MyMusic Plugins Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Adding plugin raat to MyMusic Plugins Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Adding plugin tidalconnect to MyMusic Plugins Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Loading plugins from folder /data/plugins/ Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Adding plugin rtlsdr_radio to MyMusic Plugins Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Loading plugin "system"... Aug 25 08:21:12 primo-jarrie volumio[13171]: info: Loading plugin "appearance"... Aug 25 08:21:13 primo-jarrie volumio-remote-updater[2968]: [2026-08-25 06:21:13] [connect] Successful connection Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Loading plugin "network"... Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Refreshing Cached IP Addresses Aug 25 08:21:13 primo-jarrie sudo[13202]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 25 08:21:13 primo-jarrie sudo[13202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:13 primo-jarrie sudo[13200]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 25 08:21:13 primo-jarrie sudo[13200]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Loading plugin "services"... Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Loading plugin "volumio5onboarding"... Aug 25 08:21:13 primo-jarrie sudo[13202]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Loading plugin "alsa_controller"... Aug 25 08:21:13 primo-jarrie sudo[13210]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 25 08:21:13 primo-jarrie sudo[13210]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:13 primo-jarrie sudo[13200]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:13 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Loading plugin "wizard"... Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Loading plugin "networkfs"... Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Starting Udev Watcher for removable devices Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Ignoring mount for partition: BOOT Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Ignoring mount for partition: volumio Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Ignoring mount for partition: volumio_data Aug 25 08:21:13 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Loading plugin "volumio_command_line_client"... Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Loading plugin "upnp"... Aug 25 08:21:13 primo-jarrie volumio[13171]: info: [1787638873947] Starting Upmpd Daemon Aug 25 08:21:13 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Loading plugin "my_music"... Aug 25 08:21:13 primo-jarrie volumio[13171]: info: Loading plugin "mpd"... Aug 25 08:21:13 primo-jarrie kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04ee92000 drv_status 0x0 e_type 69 e_states 8 Aug 25 08:21:14 primo-jarrie kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04ee92000 drv_status 0x0 e_type 69 e_states 8 Aug 25 08:21:14 primo-jarrie kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04ee92000 drv_status 0x0 e_type 69 e_states 8 Aug 25 08:21:14 primo-jarrie kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04ee92000 drv_status 0x0 e_type 69 e_states 8 Aug 25 08:21:14 primo-jarrie kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04ee92000 drv_status 0x0 e_type 69 e_states 8 Aug 25 08:21:14 primo-jarrie volumio[13171]: info: Loading plugin "upnp_browser"... Aug 25 08:21:14 primo-jarrie kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04ee92000 drv_status 0x0 e_type 69 e_states 8 Aug 25 08:21:14 primo-jarrie kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04ee92000 drv_status 0x0 e_type 69 e_states 8 Aug 25 08:21:14 primo-jarrie kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04ee92000 drv_status 0x0 e_type 69 e_states 8 Aug 25 08:21:14 primo-jarrie kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04ee92000 drv_status 0x0 e_type 69 e_states 8 Aug 25 08:21:14 primo-jarrie kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04ee92000 drv_status 0x0 e_type 69 e_states 8 Aug 25 08:21:15 primo-jarrie kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04ee92000 drv_status 0x0 e_type 69 e_states 0 Aug 25 08:21:15 primo-jarrie volumio[13171]: info: Starting UPNP Browser Aug 25 08:21:15 primo-jarrie volumio[13171]: info: Loading plugin "bluetooth"... Aug 25 08:21:15 primo-jarrie sudo[13210]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:16 primo-jarrie volumio[13171]: info: Applying required configuration parameters for plugin bluetooth Aug 25 08:21:16 primo-jarrie volumio[13171]: info: Applying required configuration parameters for plugin bluetooth Aug 25 08:21:16 primo-jarrie volumio[13171]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Aug 25 08:21:16 primo-jarrie volumio[13171]: info: Loading plugin "alarm-clock"... Aug 25 08:21:16 primo-jarrie volumio[13171]: info: Loading plugin "manifestui"... Aug 25 08:21:16 primo-jarrie volumio[13171]: info: Loading plugin "metavolumio"... Aug 25 08:21:17 primo-jarrie volumio[13171]: info: Loading plugin "airplay_emulation"... Aug 25 08:21:17 primo-jarrie volumio[13171]: info: Starting Shairport Sync Aug 25 08:21:17 primo-jarrie volumio[13171]: info: Loading plugin "cd_controller"... Aug 25 08:21:18 primo-jarrie volumio[13171]: info: Loading plugin "last_100"... Aug 25 08:21:18 primo-jarrie volumio[13171]: info: Loading plugin "qobuzconnect"... Aug 25 08:21:18 primo-jarrie volumio[13171]: info: Loading plugin "raat"... Aug 25 08:21:18 primo-jarrie volumio[13171]: info: RAAT Plugin loaded Aug 25 08:21:18 primo-jarrie volumio[13171]: info: Adding restartRAATSocket REST API Endpoint Aug 25 08:21:18 primo-jarrie volumio[13171]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Aug 25 08:21:18 primo-jarrie volumio[13171]: info: Loading plugin "streaming_services"... Aug 25 08:21:19 primo-jarrie volumio[13171]: info: Loading plugin "tidalconnect"... Aug 25 08:21:19 primo-jarrie volumio[13171]: info: Loading plugin "webradio"... Aug 25 08:21:19 primo-jarrie volumio[13171]: info: Loading plugin "i2s_dacs"... Aug 25 08:21:19 primo-jarrie volumio[13171]: info: I2S DAC not set, start Auto-detection Aug 25 08:21:19 primo-jarrie volumio[13171]: info: Loading plugin "volumiodiscovery"... Aug 25 08:21:19 primo-jarrie volumio[13171]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 25 08:21:19 primo-jarrie volumio[13171]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 25 08:21:19 primo-jarrie volumio[13171]: *** WARNING *** For more information see Aug 25 08:21:19 primo-jarrie volumio[13171]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 25 08:21:19 primo-jarrie volumio[13171]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 25 08:21:19 primo-jarrie node[13171]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 25 08:21:19 primo-jarrie volumio[13171]: *** WARNING *** For more information see Aug 25 08:21:19 primo-jarrie node[13171]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 25 08:21:19 primo-jarrie node[13171]: *** WARNING *** For more information see Aug 25 08:21:19 primo-jarrie node[13171]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 25 08:21:19 primo-jarrie node[13171]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 25 08:21:19 primo-jarrie node[13171]: *** WARNING *** For more information see Aug 25 08:21:19 primo-jarrie volumio[13171]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 25 08:21:19 primo-jarrie volumio[13171]: info: Discovery: Started advertising with name: Primo Jarrie Aug 25 08:21:19 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 25 08:21:19 primo-jarrie volumio[13171]: info: Loading plugin "spop"... Aug 25 08:21:21 primo-jarrie volumio[13171]: info: Plugin squeezelite_mc is not enabled Aug 25 08:21:21 primo-jarrie volumio[13171]: info: Loading plugin "multiroom"... Aug 25 08:21:21 primo-jarrie volumio5-onboarding[4128]: time=2026-08-25T06:21:21.229Z level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:50638->127.0.0.1:3000: i/o timeout" Aug 25 08:21:22 primo-jarrie volumio[13171]: info: Applying required configuration parameters for plugin multiroom Aug 25 08:21:22 primo-jarrie sudo[13238]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Aug 25 08:21:22 primo-jarrie sudo[13238]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:22 primo-jarrie sudo[13238]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:23 primo-jarrie volumio[13171]: /usr/bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Aug 25 08:21:23 primo-jarrie volumio[13171]: info: MRS: MultiRoom plugin initialized Aug 25 08:21:23 primo-jarrie volumio[13171]: info: MRS: STOPPING SNAPCLIENT Aug 25 08:21:23 primo-jarrie volumio[13171]: info: MRS: Snap server stop Aug 25 08:21:23 primo-jarrie volumio[13171]: info: MRS: STOPPING volumioStreaming Aug 25 08:21:23 primo-jarrie sudo[13255]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Aug 25 08:21:23 primo-jarrie sudo[13255]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:23 primo-jarrie volumio[13171]: info: Loading plugin "outputs"... Aug 25 08:21:23 primo-jarrie volumio[13171]: info: Loading plugin "albumart"... Aug 25 08:21:23 primo-jarrie sudo[13258]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Aug 25 08:21:23 primo-jarrie sudo[13258]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:23 primo-jarrie sudo[13261]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Aug 25 08:21:23 primo-jarrie sudo[13261]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:23 primo-jarrie sudo[13262]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Aug 25 08:21:23 primo-jarrie sudo[13262]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:23 primo-jarrie volumio[13171]: info: Plugin example_plugin is not enabled Aug 25 08:21:23 primo-jarrie volumio[13171]: info: Loading plugin "hi_res_audio"... Aug 25 08:21:23 primo-jarrie sudo[13262]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:23 primo-jarrie sudo[13258]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:23 primo-jarrie sudo[13255]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:23 primo-jarrie sudo[13261]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:23 primo-jarrie volumio[13265]: Forking 3 albumart workers Aug 25 08:21:25 primo-jarrie volumio[13171]: info: Applying required configuration parameters for plugin hi_res_audio Aug 25 08:21:25 primo-jarrie volumio[13171]: info: Loading plugin "inputs"... Aug 25 08:21:25 primo-jarrie volumio[13275]: Starting albumart workers Aug 25 08:21:25 primo-jarrie volumio[13273]: Starting albumart workers Aug 25 08:21:25 primo-jarrie volumio[13274]: Starting albumart workers Aug 25 08:21:25 primo-jarrie volumio-remote-updater[2968]: [2026-08-25 06:21:25] [connect] Successful connection Aug 25 08:21:26 primo-jarrie volumio[13171]: info: Loading plugin "qobuz"... Aug 25 08:21:26 primo-jarrie volumio5-onboarding[4128]: time=2026-08-25T06:21:26.265Z level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded" Aug 25 08:21:27 primo-jarrie volumio[13171]: info: Loading plugin "smart_inputs"... Aug 25 08:21:27 primo-jarrie volumio[13171]: info: Loading plugin "tidal"... Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Loading plugin "primo2rev2control"... Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Adding this device properties Aug 25 08:21:29 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Setting Additional Device Volumio Properties: [object Object] Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Loading plugin "updater_comm"... Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Loading plugin "cec_controller"... Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Applying required configuration parameters for plugin cec_controller Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Plugin mpdemulation is not enabled Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Loading plugin "rest_api"... Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Loading plugin "websocket"... Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Starting Socket.io Server version 1.7.4 Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Loading plugin "80s80s"... Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Applying required configuration parameters for plugin 80s80s Aug 25 08:21:29 primo-jarrie volumio[13171]: info: [1787638889853] [80s80s] API delay: 30 Aug 25 08:21:29 primo-jarrie volumio[13171]: info: Loading plugin "podcast"... Aug 25 08:21:30 primo-jarrie volumio[13171]: info: ControllerPodcast::constructor Aug 25 08:21:30 primo-jarrie volumio[13171]: info: Loading plugin "rtlsdr_radio"... Aug 25 08:21:30 primo-jarrie volumio[13171]: info: [RTL-SDR Radio] Loaded FM region data Aug 25 08:21:30 primo-jarrie volumio[13171]: info: Loading plugin "Systeminfo"... Aug 25 08:21:31 primo-jarrie volumio[13171]: info: Loading i18n strings for locale fr Aug 25 08:21:31 primo-jarrie volumio[13171]: Updating browse sources language Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::initPlayerControls Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 08:21:31 primo-jarrie volumio[13171]: Express server listening on port 3000 Aug 25 08:21:31 primo-jarrie volumio[13171]: [Metrics] WebUI: 21s 138.08ms Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreStateMachine::resetVolumioState Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreStateMachine::getcurrentVolume Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioRetrievevolume Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreStateMachine::pushState Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioPushState Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 08:21:31 primo-jarrie sudo[13343]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 25 08:21:31 primo-jarrie sudo[13343]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:31 primo-jarrie volumio[13171]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Aug 25 08:21:31 primo-jarrie volumio[13171]: info: Completed loading Core Plugins Aug 25 08:21:31 primo-jarrie volumio[13171]: info: Preparing to generate the ALSA configuration file Aug 25 08:21:31 primo-jarrie sudo[13345]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 25 08:21:31 primo-jarrie sudo[13345]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:31 primo-jarrie sudo[13343]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:31 primo-jarrie sudo[13345]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:31 primo-jarrie volumio[13171]: info: Volumio Network Manager: Network status updated: 1 Aug 25 08:21:31 primo-jarrie volumio[13171]: info: MRS: Removed streaming files Aug 25 08:21:31 primo-jarrie volumio[13171]: info: MRS: volumioStreaming STOPPED Aug 25 08:21:31 primo-jarrie volumio[13171]: info: MRS: SNAPSERVER STOPPED Aug 25 08:21:31 primo-jarrie volumio[13171]: info: MRS: SNAPCLIENT STOPPED Aug 25 08:21:31 primo-jarrie volumio[13171]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Aug 25 08:21:31 primo-jarrie volumio[13171]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 25 08:21:31 primo-jarrie volumio[13171]: info: Reading ALSA contributions from plugins. Aug 25 08:21:31 primo-jarrie volumio[13171]: info: Reloading queue from file Aug 25 08:21:31 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreStateMachine::setRepeat null single undefined Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreStateMachine::pushState Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:31 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioPushState Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreStateMachine::setRandom null Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreStateMachine::pushState Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioPushState Aug 25 08:21:32 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 25 08:21:32 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 25 08:21:32 primo-jarrie sudo[13357]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 25 08:21:32 primo-jarrie sudo[13357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Discovery: adding e2dd10a5-5281-4cc3-abad-5454e41f425d Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Discovery: Found device Primo Jarrie Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioGetState Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:32 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output for this device Aug 25 08:21:32 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Adding audio output: Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Adding audio output: Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Discovery: this is already registered, e2dd10a5-5281-4cc3-abad-5454e41f425d Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Discovery: Found device Primo Jarrie Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioGetState Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Asound.conf file unchanged, so no further update is needed Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Output device has changed, restarting MPD Aug 25 08:21:32 primo-jarrie sudo[13357]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Output device has changed, restarting Shairport Sync Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 08:21:32 primo-jarrie sudo[13360]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 25 08:21:32 primo-jarrie sudo[13360]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:32 primo-jarrie sudo[13360]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:32 primo-jarrie sudo[13362]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 25 08:21:32 primo-jarrie sudo[13362]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 25 08:21:32 primo-jarrie volumio[13171]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:32 primo-jarrie volumio[13171]: info: ___________ START PLUGINS ___________ Aug 25 08:21:32 primo-jarrie systemd[1]: Stopping mpd.service - Music Player Daemon... Aug 25 08:21:32 primo-jarrie kernel: aml_spdif_open Aug 25 08:21:32 primo-jarrie kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Aug 25 08:21:32 primo-jarrie kernel: spdif_a keep clk continuous Aug 25 08:21:32 primo-jarrie kernel: aml_spdif_close Aug 25 08:21:32 primo-jarrie kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Aug 25 08:21:32 primo-jarrie bluealsa[3394]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_5D_DF_E9_6B_3B_42/mcp/player0, ...) Aug 25 08:21:32 primo-jarrie volumio5-onboarding[4128]: time=2026-08-25T06:21:32.275Z level=ERROR msg="failed to cancel pairing for disconnected device" component=ble/conn device=88:B9:51:EC:5F:7E error="Method \"CancelPairing\" with signature \"\" on interface \"org.bluez.Device1\" doesn't exist\n" Aug 25 08:21:32 primo-jarrie volumio[13171]: info: ControllerMpd::onStart: Initializing MPD Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Creating MPD Configuration file Aug 25 08:21:32 primo-jarrie sudo[13372]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Aug 25 08:21:32 primo-jarrie sudo[13372]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 08:21:32 primo-jarrie volumio[13171]: info: [1787638892308] CoreMusicLibrary::Adding element Serveurs Média Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 08:21:32 primo-jarrie sudo[13374]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 25 08:21:32 primo-jarrie sudo[13374]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:32 primo-jarrie volumio[13171]: info: UPNP Browser: Client initialized successfully Aug 25 08:21:32 primo-jarrie volumio[13171]: ------------------------------------ BT MESSAGE: [FUNC] onStart Aug 25 08:21:32 primo-jarrie volumio[13171]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Aug 25 08:21:32 primo-jarrie sudo[13374]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:32 primo-jarrie sudo[13377]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 25 08:21:32 primo-jarrie sudo[13377]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:32 primo-jarrie volumio[13171]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Aug 25 08:21:32 primo-jarrie volumio[13171]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Aug 25 08:21:32 primo-jarrie volumio[13171]: ------------------------------------ BT MESSAGE: [metaCache] Deleted stale cache file: meta-5D:DF:E9:6B:3B:42.json Aug 25 08:21:32 primo-jarrie systemd[1]: mpd.service: Deactivated successfully. Aug 25 08:21:32 primo-jarrie systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 25 08:21:32 primo-jarrie systemd[1]: mpd.socket: Deactivated successfully. Aug 25 08:21:32 primo-jarrie systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 25 08:21:32 primo-jarrie systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Adding METAVOLUMIO REST API Endpoints Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 08:21:32 primo-jarrie systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 25 08:21:32 primo-jarrie systemd[1]: Starting mpd.service - Music Player Daemon... Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 25 08:21:32 primo-jarrie sudo[13372]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 08:21:32 primo-jarrie systemd[1]: mpd.service: Deactivated successfully. Aug 25 08:21:32 primo-jarrie systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 25 08:21:32 primo-jarrie systemd[1]: mpd.socket: Deactivated successfully. Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 25 08:21:32 primo-jarrie systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 25 08:21:32 primo-jarrie systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Preparing CD Folders Aug 25 08:21:32 primo-jarrie systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Adding CD REST API Endpoints Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Starting UDEV Watcher for CD Aug 25 08:21:32 primo-jarrie volumio[13171]: info: Detecting CD presence with UDEV Aug 25 08:21:32 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Aug 25 08:21:32 primo-jarrie systemd[1]: Starting mpd.service - Music Player Daemon... Aug 25 08:21:32 primo-jarrie bluetoothd[3393]: Path / reserved for Adv Monitor app :1.176 Aug 25 08:21:32 primo-jarrie bluetoothd[3393]: Adv Monitor app :1.176 disconnected from D-Bus Aug 25 08:21:32 primo-jarrie sudo[13397]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 25 08:21:32 primo-jarrie sudo[13397]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 25 08:21:32 primo-jarrie sudo[13397]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:36 primo-jarrie mpd[13401]: 2026-08-25T08:21:36 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 25 08:21:36 primo-jarrie systemd[1]: Started mpd.service - Music Player Daemon. Aug 25 08:21:36 primo-jarrie sudo[13362]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:36 primo-jarrie sudo[13377]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:37 primo-jarrie volumio[13171]: warn: [cd-plugin] cdspeedctl: device or media not ready Aug 25 08:21:37 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 08:21:37 primo-jarrie volumio[13171]: info: [1787638897602] CoreMusicLibrary::Adding element Last_100 Aug 25 08:21:37 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 08:21:37 primo-jarrie volumio[13171]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Aug 25 08:21:37 primo-jarrie volumio[13171]: info: QobuzConnect: Starting Qobuz Connect socket and service Aug 25 08:21:37 primo-jarrie volumio[13171]: info: Starting RAAT Plugin Aug 25 08:21:37 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Aug 25 08:21:37 primo-jarrie volumio[13171]: info: Additional UI Settings Added for plugin music_service/raat Aug 25 08:21:37 primo-jarrie volumio[13171]: info: Registering DSP Elements listener and retrieving current ones Aug 25 08:21:37 primo-jarrie volumio[13171]: info: Additional DSP elements updated Aug 25 08:21:37 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:37 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:37 primo-jarrie volumio[13171]: info: Updating RAAT Signal Path Aug 25 08:21:37 primo-jarrie volumio[13171]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Aug 25 08:21:37 primo-jarrie volumio[13171]: info: Streaming services startup Aug 25 08:21:37 primo-jarrie volumio[13171]: info: Starting Streaming Daemon Aug 25 08:21:37 primo-jarrie sudo[13425]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 25 08:21:37 primo-jarrie sudo[13425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:37 primo-jarrie sudo[13427]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 25 08:21:37 primo-jarrie sudo[13427]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:37 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 08:21:37 primo-jarrie volumio[13171]: info: [1787638897708] CoreMusicLibrary::Adding element Webradio Aug 25 08:21:37 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 08:21:37 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 25 08:21:37 primo-jarrie volumio[13171]: info: Initializing BBC Radios Aug 25 08:21:37 primo-jarrie sudo[13435]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 25 08:21:37 primo-jarrie sudo[13425]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:37 primo-jarrie sudo[13435]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:37 primo-jarrie sudo[13427]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:37 primo-jarrie sudo[13440]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 25 08:21:37 primo-jarrie sudo[13440]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:37 primo-jarrie systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Aug 25 08:21:37 primo-jarrie systemd[1]: vtcs.service: Deactivated successfully. Aug 25 08:21:37 primo-jarrie systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Aug 25 08:21:37 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 25 08:21:37 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 08:21:37 primo-jarrie sudo[13435]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:37 primo-jarrie volumio[13171]: info: Creating Spotify config file Aug 25 08:21:37 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:37 primo-jarrie systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Aug 25 08:21:37 primo-jarrie qobuz-connect[4265]: 20260825 08:21:37.851 [4265.4265] INFO SampleApp: Stopping Local configuration server Aug 25 08:21:38 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Aug 25 08:21:38 primo-jarrie volumio[13171]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 25 08:21:38 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:38 primo-jarrie volumio[13171]: error: Hi Res Audio Failed Login: Missing Login Data Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Adding HIGHRESAUDIO REST API Endpoints Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Aug 25 08:21:38 primo-jarrie kernel: aml_spdif_open Aug 25 08:21:38 primo-jarrie kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Aug 25 08:21:38 primo-jarrie kernel: spdif_a keep clk continuous Aug 25 08:21:38 primo-jarrie kernel: aml_spdif_close Aug 25 08:21:38 primo-jarrie kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Initializing Serial Communication on port /dev/ttyS3 Aug 25 08:21:38 primo-jarrie kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 115200 to 115200 Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Touch Event Listener Process Starting Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Adding inputs REST Endpoints Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Scanning Audio Inputs Aug 25 08:21:38 primo-jarrie sudo[13455]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Aug 25 08:21:38 primo-jarrie sudo[13455]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:38 primo-jarrie sudo[13455]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Checking against Known Cards name Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Checking against Known Cards name Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Checking against Known Cards name Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Checking against Known Cards name Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Checking against Known Cards name Aug 25 08:21:38 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [1787638898212] CoreMusicLibrary::Adding element Loopback Aug 25 08:21:38 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 08:21:38 primo-jarrie volumio[13171]: Cannot find translation for source Loopback Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Checking against Known Cards name Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Checking against Known Cards name Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Checking against Known Cards name Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Checking against Known Cards name Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Checking against Known Cards name Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Checking against Known Cards name Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Adding Server instance for streaming Aug 25 08:21:38 primo-jarrie sudo[13461]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Aug 25 08:21:38 primo-jarrie sudo[13461]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:38 primo-jarrie sudo[13461]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:38 primo-jarrie sudo[13477]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Aug 25 08:21:38 primo-jarrie sudo[13477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:38 primo-jarrie sudo[13477]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:38 primo-jarrie sudo[13480]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Aug 25 08:21:38 primo-jarrie sudo[13480]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:38 primo-jarrie sudo[13480]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:38 primo-jarrie sudo[13483]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Aug 25 08:21:38 primo-jarrie sudo[13483]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:38 primo-jarrie sudo[13483]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:38 primo-jarrie volumio[13171]: info: MP1 Muting HDMI Output Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Starting CEC Event listener Aug 25 08:21:38 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [1787638898462] CoreMusicLibrary::Adding element 80s80s Radio Aug 25 08:21:38 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 08:21:38 primo-jarrie volumio[13171]: Cannot find translation for source Loopback Aug 25 08:21:38 primo-jarrie volumio[13171]: Cannot find translation for source 80s80s Radio Aug 25 08:21:38 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [1787638898475] CoreMusicLibrary::Adding element Podcast Aug 25 08:21:38 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 08:21:38 primo-jarrie volumio[13171]: Cannot find translation for source Loopback Aug 25 08:21:38 primo-jarrie volumio[13171]: Cannot find translation for source 80s80s Radio Aug 25 08:21:38 primo-jarrie volumio[13171]: Cannot find translation for source Podcast Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [RTL-SDR Radio] Starting plugin Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [RTL-SDR Radio] Loaded i18n strings for language: fr Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Volumio Calling Home Aug 25 08:21:38 primo-jarrie volumio[13171]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Aug 25 08:21:38 primo-jarrie volumio[13171]: (node:13171) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Aug 25 08:21:38 primo-jarrie volumio[13171]: (Use `node --trace-deprecation ...` to show where the warning was created) Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [RTL-SDR Radio] snd-aloop already loaded Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Stopping AccessToken refresher cron for QOBUZ Aug 25 08:21:38 primo-jarrie volumio[13171]: info: AccessToken refresher cron started for QOBUZ Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Adding TIDAL REST API Endpoints Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [RTL-SDR Radio] No stations database found, creating v2 Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [RTL-SDR Radio] Database loaded at: 2026-08-25T06:21:38.705Z Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [RTL-SDR Radio] Loading blocklist from: /data/plugins/music_service/rtlsdr_radio/blocklist.json Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [RTL-SDR Radio] Got 21 phrases from file Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [RTL-SDR Radio] Updated metadata blocklist Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [RTL-SDR Radio] Metadata module now has 21 phrases Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Adding QOBUZ REST API Endpoints Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [RTL-SDR Radio] Management server started on port 3456 Aug 25 08:21:38 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [1787638898861] CoreMusicLibrary::Adding element FM/DAB Radio Aug 25 08:21:38 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 08:21:38 primo-jarrie volumio[13171]: Cannot find translation for source Loopback Aug 25 08:21:38 primo-jarrie volumio[13171]: Cannot find translation for source 80s80s Radio Aug 25 08:21:38 primo-jarrie volumio[13171]: Cannot find translation for source Podcast Aug 25 08:21:38 primo-jarrie volumio[13171]: Cannot find translation for source FM/DAB Radio Aug 25 08:21:38 primo-jarrie volumio[13171]: info: [RTL-SDR Radio] Plugin started successfully Aug 25 08:21:38 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Serial port opened successfully Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Sending serial start messages Aug 25 08:21:38 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:38 primo-jarrie volumio[13171]: info: Reporting MCU Network Status: 1 Aug 25 08:21:39 primo-jarrie volumio[13171]: info: Touch Event Listener Process Closed Aug 25 08:21:39 primo-jarrie volumio[13171]: error: Cannot start Volumio Streaming Daemon Aug 25 08:21:39 primo-jarrie volumio[13171]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 25 08:21:39 primo-jarrie volumio[13171]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 25 08:21:39 primo-jarrie volumio[13171]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered on Aug 25 08:21:39 primo-jarrie volumio[13171]: info: MPD Permissions set Aug 25 08:21:39 primo-jarrie sudo[13499]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Aug 25 08:21:39 primo-jarrie sudo[13499]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:39 primo-jarrie volumio[13171]: info: MPD Permissions set Aug 25 08:21:39 primo-jarrie volumio[13171]: info: Upmpdcli Daemon Started Aug 25 08:21:39 primo-jarrie systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Aug 25 08:21:39 primo-jarrie sudo[13499]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:39 primo-jarrie systemd[1]: qobuz-connect.service: Deactivated successfully. Aug 25 08:21:39 primo-jarrie systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Aug 25 08:21:39 primo-jarrie systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Aug 25 08:21:39 primo-jarrie sudo[13440]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:39 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 25 08:21:39 primo-jarrie volumio[13171]: info: Volumio called home Aug 25 08:21:39 primo-jarrie volumio[13171]: info: Spotify config file written Aug 25 08:21:39 primo-jarrie sudo[13514]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Aug 25 08:21:39 primo-jarrie sudo[13514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:39 primo-jarrie systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Aug 25 08:21:39 primo-jarrie systemd[1]: go-librespot-daemon.service: Deactivated successfully. Aug 25 08:21:39 primo-jarrie systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 08:21:39 primo-jarrie systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 08:21:39 primo-jarrie sudo[13514]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:39 primo-jarrie go-librespot[13523]: go-librespot daemon starting... Aug 25 08:21:39 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:39+02:00" level=info msg="running go-librespot 0.7.1" Aug 25 08:21:39 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:39+02:00" level=debug msg="app state loaded" Aug 25 08:21:39 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:39+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 08:21:39 primo-jarrie volumio[13171]: error: MPD error: The expression evaluated to a falsy value: Aug 25 08:21:39 primo-jarrie volumio[13171]: assert.ok(self.idling) Aug 25 08:21:39 primo-jarrie volumio[13171]: error: The expression evaluated to a falsy value: Aug 25 08:21:39 primo-jarrie volumio[13171]: assert.ok(self.idling) Aug 25 08:21:39 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Aug 25 08:21:39 primo-jarrie volumio[13171]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully Aug 25 08:21:39 primo-jarrie volumio[13171]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart Aug 25 08:21:39 primo-jarrie volumio[13171]: info: MPD running with PID13401 Aug 25 08:21:39 primo-jarrie volumio[13171]: ,establishing connection Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 25 08:21:39 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 08:21:39 primo-jarrie volumio[13171]: info: No need to fix Spotify hosts Aug 25 08:21:39 primo-jarrie volumio[13171]: error: updateQueue error: null Aug 25 08:21:39 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:39+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 25 08:21:39 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:39+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 25 08:21:39 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:39+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 25 08:21:39 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:39+02:00" level=info msg="zeroconf server listening on port 33967" Aug 25 08:21:39 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:39+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 08:21:39 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Aug 25 08:21:40 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Aug 25 08:21:40 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:40+02:00" level=debug msg="obtained new client token: AAEpmaZXLsjgjEo2wXKxzahjV4tBoJdMhvJnayMz6ISFQAvwp+6PeQsvtEj/nG2KQ4a4nnIPTh5UmtSfZhE3Dig+E1y2ERmzPe6k2noO8tixlSkpen3MDN7GyY0fDQFcOB8sID2MeFwZ6UFCD0q5JLS76TynUGNus5KfN6/7HLbJ+vFLdWBfxU/Y+qCl1Zk/iRhKAe4BVij+JWNxuauUcbmW1FbuN+tSHJKkmho/V4JQF2uvn5nwO8E=" Aug 25 08:21:40 primo-jarrie volumio[13171]: info: New Spotify access tokenBQA7F3CpvM... Aug 25 08:21:40 primo-jarrie volumio[13171]: info: Spotify credentials grant success - running version from March 24, 2019 Aug 25 08:21:40 primo-jarrie volumio[13171]: error: updateQueue error: null Aug 25 08:21:40 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:40+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 25 08:21:40 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:40+02:00" level=debug msg="completed keyexchange" Aug 25 08:21:40 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:40+02:00" level=debug msg="completed challenge" Aug 25 08:21:40 primo-jarrie volumio[13171]: info: Executing endpoint qc_getconfig Aug 25 08:21:40 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Aug 25 08:21:40 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:40+02:00" level=info msg="authenticated AP" username="mo*******nt" Aug 25 08:21:40 primo-jarrie qobuz-connect[13505]: 20260825 08:21:40.245 [13505.13505] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Aug 25 08:21:40 primo-jarrie volumio[13171]: info: Starting Shairport Sync Aug 25 08:21:40 primo-jarrie qobuz-connect[13505]: 20260825 08:21:40.251 [13505.13505] INFO VolumeManager: [0xac03c228]: Setting new playback volume: 75 Aug 25 08:21:40 primo-jarrie qobuz-connect[13505]: 20260825 08:21:40.251 [13505.13505] INFO VolumeManager: [0xac03c228]: Setting new mute state: 0 Aug 25 08:21:40 primo-jarrie qobuz-connect[13505]: 20260825 08:21:40.251 [13505.13505] INFO AudioStreamManager: [0xac03bf80]: Setting new audio download buffer size: 1048576 Aug 25 08:21:40 primo-jarrie qobuz-connect[13505]: 20260825 08:21:40.251 [13505.13505] INFO QobuzConnect: [0xac03caf0]: Client initialized! Aug 25 08:21:40 primo-jarrie qobuz-connect[13505]: 20260825 08:21:40.251 [13505.13505] INFO SampleApp: Starting Avahi advertising, name: Primo Jarrie, service name: _qobuz-connect._tcp Aug 25 08:21:40 primo-jarrie volumio[13171]: info: Starting Shairport Sync Aug 25 08:21:40 primo-jarrie qobuz-connect[13505]: 20260825 08:21:40.270 [13505.13505] INFO LocalConfigManager: [0xac03bca8]: Starting Local Configuration server Aug 25 08:21:40 primo-jarrie qobuz-connect[13505]: 20260825 08:21:40.270 [13505.13505] INFO SampleApp: Starting Local configuration server Aug 25 08:21:40 primo-jarrie qobuz-connect[13505]: 20260825 08:21:40.271 [13505.13505] INFO SampleApp: Connected to UNIX socket client 0xac0268f8 Aug 25 08:21:40 primo-jarrie volumio[13171]: info: Starting Shairport Sync Aug 25 08:21:40 primo-jarrie volumio[13171]: info: MRS: Found cast device: Chromecast-681e6544fb1cd892e09ae2c0b49cd86a Aug 25 08:21:40 primo-jarrie volumio[13171]: info: Adding audio output: Aug 25 08:21:40 primo-jarrie volumio[13171]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Aug 25 08:21:40 primo-jarrie volumio[13171]: info: QobuzConnect: QOBUZ Connect daemon connected Aug 25 08:21:40 primo-jarrie sudo[13553]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 25 08:21:40 primo-jarrie sudo[13553]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:40 primo-jarrie sudo[13557]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 25 08:21:40 primo-jarrie sudo[13557]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:40 primo-jarrie sudo[13559]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 25 08:21:40 primo-jarrie sudo[13559]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:40 primo-jarrie qobuz-connect[13505]: 20260825 08:21:40.396 [13505.13505] INFO SampleApp: Playback volume changed: 75 Aug 25 08:21:40 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Aug 25 08:21:40 primo-jarrie go-librespot[13524]: time="2026-08-25T08:21:40+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 08:21:40 primo-jarrie systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 08:21:40 primo-jarrie systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 08:21:40 primo-jarrie systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 25 08:21:40 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioGetState Aug 25 08:21:40 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:40 primo-jarrie systemd[1]: shairport-sync.service: Deactivated successfully. Aug 25 08:21:40 primo-jarrie systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 25 08:21:40 primo-jarrie systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 25 08:21:40 primo-jarrie sudo[13553]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:40 primo-jarrie sudo[13559]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:40 primo-jarrie sudo[13557]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:40 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Aug 25 08:21:40 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioGetState Aug 25 08:21:40 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:40 primo-jarrie volumio[13171]: info: Shairport-Sync Started Aug 25 08:21:40 primo-jarrie volumio[13171]: Error adding Membership: Error: addMembership EINVAL Aug 25 08:21:40 primo-jarrie volumio[13171]: info: Shairport-Sync Started Aug 25 08:21:40 primo-jarrie volumio[13171]: info: Shairport-Sync Started Aug 25 08:21:40 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Aug 25 08:21:40 primo-jarrie systemd[1]: setdatetime-helper.service: Deactivated successfully. Aug 25 08:21:40 primo-jarrie systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Aug 25 08:21:40 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioGetState Aug 25 08:21:40 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:40 primo-jarrie volumio-remote-updater[2968]: [2026-08-25 06:21:40] [connect] Successful connection Aug 25 08:21:40 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Aug 25 08:21:40 primo-jarrie volumio-remote-updater[2968]: [2026-08-25 06:21:40] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1787638900 101 Aug 25 08:21:40 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 3 Aug 25 08:21:40 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:40 primo-jarrie volumio[13171]: info: TidalConnect service stoped! Aug 25 08:21:40 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:40 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:40 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:40 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:40 primo-jarrie volumio[13171]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 25 08:21:40 primo-jarrie volumio[13171]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie sudo[13596]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 25 08:21:41 primo-jarrie sudo[13596]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: SPOTIFY: User informations: {"account_id":"PEYJAI65MF","country":"FR","display_name":"Christophe Rehm","email":"christophe.rehm@laposte.net","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/monkeypoint"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/monkeypoint","id":"monkeypoint","images":[{"height":300,"url":"https://platform-lookaside.fbsbx.com/platform/profilepic/?asid=10201941534041767&height=300&width=300&ext=1790230900&hash=AftCfTLu9FQQW3i_FtsVX1WK","width":300},{"height":64,"url":"https://platform-lookaside.fbsbx.com/platform/profilepic/?asid=10201941534041767&height=50&width=50&ext=1790230900&hash=AftjOc8UcWps2y2CbKN5zg9v","width":64}],"product":"premium","type":"user","uri":"spotify:user:monkeypoint"} Aug 25 08:21:41 primo-jarrie volumio[13171]: info: Spotify Successfully logged in Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 08:21:41 primo-jarrie volumio[13171]: info: [1787638901074] CoreMusicLibrary::Adding element Spotify Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 08:21:41 primo-jarrie volumio[13171]: Cannot find translation for source Loopback Aug 25 08:21:41 primo-jarrie volumio[13171]: Cannot find translation for source 80s80s Radio Aug 25 08:21:41 primo-jarrie volumio[13171]: Cannot find translation for source Podcast Aug 25 08:21:41 primo-jarrie volumio[13171]: Cannot find translation for source FM/DAB Radio Aug 25 08:21:41 primo-jarrie volumio[13171]: Cannot find translation for source Spotify Aug 25 08:21:41 primo-jarrie systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Aug 25 08:21:41 primo-jarrie sudo[13596]: pam_unix(sudo:session): session closed for user root Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: Initializing I2S Bus Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie kernel: aml_tdm_open Aug 25 08:21:41 primo-jarrie kernel: Not init audio effects Aug 25 08:21:41 primo-jarrie kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Aug 25 08:21:41 primo-jarrie kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Aug 25 08:21:41 primo-jarrie kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Aug 25 08:21:41 primo-jarrie kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 Aug 25 08:21:41 primo-jarrie kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc03d1d5218, id(1), clksel(1) Aug 25 08:21:41 primo-jarrie kernel: aml_dai_set_tdm_fmt(), fmt not change Aug 25 08:21:41 primo-jarrie kernel: dump_pcm_setting(ffffffc03d1d5218) Aug 25 08:21:41 primo-jarrie kernel: pcm_mode(1) Aug 25 08:21:41 primo-jarrie kernel: sysclk(11289600) Aug 25 08:21:41 primo-jarrie kernel: sysclk_bclk_ratio(4) Aug 25 08:21:41 primo-jarrie kernel: bclk(2822400) Aug 25 08:21:41 primo-jarrie kernel: bclk_lrclk_ratio(64) Aug 25 08:21:41 primo-jarrie kernel: lrclk(44100) Aug 25 08:21:41 primo-jarrie kernel: tx_mask(0x3) Aug 25 08:21:41 primo-jarrie kernel: rx_mask(0x3) Aug 25 08:21:41 primo-jarrie kernel: slots(2) Aug 25 08:21:41 primo-jarrie kernel: slot_width(32) Aug 25 08:21:41 primo-jarrie kernel: lane_mask_in(0x2) Aug 25 08:21:41 primo-jarrie kernel: lane_mask_out(0x1) Aug 25 08:21:41 primo-jarrie kernel: lane_oe_mask_in(0x0) Aug 25 08:21:41 primo-jarrie kernel: lane_oe_mask_out(0x0) Aug 25 08:21:41 primo-jarrie kernel: lane_lb_mask_in(0x0) Aug 25 08:21:41 primo-jarrie kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Aug 25 08:21:41 primo-jarrie kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Aug 25 08:21:41 primo-jarrie kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 Aug 25 08:21:41 primo-jarrie kernel: aml_dai_set_clkdiv, div 4, clksel(1) Aug 25 08:21:41 primo-jarrie kernel: aml_dai_set_bclk_ratio, select I2S mode Aug 25 08:21:41 primo-jarrie kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B Aug 25 08:21:41 primo-jarrie kernel: aml_tdm_prepare(), reset fddr Aug 25 08:21:41 primo-jarrie kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Aug 25 08:21:41 primo-jarrie kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Aug 25 08:21:41 primo-jarrie kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Aug 25 08:21:41 primo-jarrie kernel: tdm playback mute: 0, lane_cnt = 8 Aug 25 08:21:41 primo-jarrie kernel: asoc-aml-card auge_sound: tdm playback enable Aug 25 08:21:41 primo-jarrie kernel: spdif_a is set to enable Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: Executing endpoint tc_getconfig Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Aug 25 08:21:41 primo-jarrie vtcs[13601]: STARTING TidalConnect services, version: 1.6.1 Aug 25 08:21:41 primo-jarrie vtcs[13601]: STARTED TidalConnect services. Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: Executing endpoint tc_connect Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Aug 25 08:21:41 primo-jarrie volumio[13171]: info: Connecting to TidalConnect Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::servicePushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreStateMachine::pushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioPushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioGetState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output update for this device Aug 25 08:21:41 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: CURRENT POSITION 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreStateMachine::syncState stateService stop Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreStateMachine::syncState currentStatus stop Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreStateMachine::pushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioPushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioGetState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output update for this device Aug 25 08:21:41 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output Aug 25 08:21:41 primo-jarrie volumio[13171]: info: No code Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreStateMachine::pushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioPushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioGetState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output update for this device Aug 25 08:21:41 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::servicePushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreStateMachine::pushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioPushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioGetState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output update for this device Aug 25 08:21:41 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: CURRENT POSITION 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreStateMachine::syncState stateService stop Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreStateMachine::syncState currentStatus stop Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreStateMachine::pushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioPushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioGetState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output update for this device Aug 25 08:21:41 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output Aug 25 08:21:41 primo-jarrie volumio[13171]: info: No code Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreStateMachine::pushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioPushState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CoreCommandRouter::volumioGetState Aug 25 08:21:41 primo-jarrie volumio[13171]: info: CorePlayQueue::getTrack 0 Aug 25 08:21:41 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output update for this device Aug 25 08:21:41 primo-jarrie volumio[13171]: info: MRS: Pushing multiroomSync output Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:41 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie volumio[13171]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Aug 25 08:21:42 primo-jarrie kernel: asoc-aml-card auge_sound: tdm playback stop Aug 25 08:21:42 primo-jarrie kernel: spdif_a is set to disable Aug 25 08:21:42 primo-jarrie kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Aug 25 08:21:42 primo-jarrie kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B Aug 25 08:21:42 primo-jarrie kernel: tdm playback mute: 1, lane_cnt = 8 Aug 25 08:21:42 primo-jarrie kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Aug 25 08:21:42 primo-jarrie volumio[13171]: info: Successfully initialized Primo I2S Bus Aug 25 08:21:43 primo-jarrie volumio[13171]: info: go-librespot daemon successfully initialized Aug 25 08:21:43 primo-jarrie volumio[13171]: info: MRS: Getting audio outputs on start Aug 25 08:21:43 primo-jarrie volumio[13171]: info: MRS: Requesting all other devices output Aug 25 08:21:43 primo-jarrie systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Aug 25 08:21:43 primo-jarrie systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 08:21:43 primo-jarrie systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 08:21:43 primo-jarrie go-librespot[13621]: go-librespot daemon starting... Aug 25 08:21:43 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:43+02:00" level=info msg="running go-librespot 0.7.1" Aug 25 08:21:43 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:43+02:00" level=debug msg="app state loaded" Aug 25 08:21:43 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:43+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 08:21:43 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:43+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 08:21:43 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:43+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 08:21:43 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:43+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 08:21:43 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:43+02:00" level=info msg="zeroconf server listening on port 38117" Aug 25 08:21:43 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:43+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 08:21:44 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:44+02:00" level=debug msg="obtained new client token: AAE9Jo6WhI02WOjibM9D7RQdKhmZBv1Umlvhw8wAtpXi/dvnDE3zx3ZJzMtPZ5MUz/W2zBUeByUXtLB0vZ2e/OP6zuKc9giOYIXW8rcwLuekNgOvIdBxsyOF3z2RqMeI/qWZmvhvAOYtoVnqQMedTN/6eh0uQF9xYKSc6P+yQOqa3McoobKmz6k26I9DqipQYnNh/CR2YXpE+nE4lXA7LF+e6W1G8wPpKssXKMU7Vt9RFzRfH70I83o=" Aug 25 08:21:44 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:44+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 25 08:21:44 primo-jarrie volumio[13171]: info: TidalConnect service started! Aug 25 08:21:44 primo-jarrie volumio[13171]: info: Completed starting Core Plugins Aug 25 08:21:44 primo-jarrie volumio[13171]: info: ------------------------------------------- Aug 25 08:21:44 primo-jarrie volumio[13171]: info: ----- MyVolumio plugins startup ---- Aug 25 08:21:44 primo-jarrie volumio[13171]: info: ------------------------------------------- Aug 25 08:21:44 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 25 08:21:44 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:44+02:00" level=debug msg="completed keyexchange" Aug 25 08:21:44 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:44+02:00" level=debug msg="completed challenge" Aug 25 08:21:44 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:44+02:00" level=info msg="authenticated AP" username="mo*******nt" Aug 25 08:21:44 primo-jarrie go-librespot[13622]: time="2026-08-25T08:21:44+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 08:21:44 primo-jarrie systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 08:21:44 primo-jarrie systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 08:21:44 primo-jarrie volumio[13171]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Aug 25 08:21:46 primo-jarrie volumio[13171]: info: Initializing connection to go-librespot Websocket Aug 25 08:21:46 primo-jarrie volumio[13171]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 08:21:47 primo-jarrie systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Aug 25 08:21:47 primo-jarrie systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 08:21:47 primo-jarrie systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 08:21:47 primo-jarrie go-librespot[13649]: go-librespot daemon starting... Aug 25 08:21:47 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:47+02:00" level=info msg="running go-librespot 0.7.1" Aug 25 08:21:47 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:47+02:00" level=debug msg="app state loaded" Aug 25 08:21:47 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:47+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 08:21:47 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:47+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 08:21:47 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:47+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 08:21:47 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:47+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 08:21:47 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:47+02:00" level=info msg="zeroconf server listening on port 40377" Aug 25 08:21:47 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:47+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 08:21:48 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:48+02:00" level=debug msg="obtained new client token: AAERnrnWsTLIxkVfUsRfZQ99/A67cVXuabD2tDDz89VszMScI0irHK/QqiCaRJV/qPSK2G2sNtW5bpObLEx/0NVWm+E2i7AoU0rEhzpmcCnZyohyZpU5nm9aj0E7S/YvqWAukngXLiec4NDe+vUS+gb8uiUpUn3Xr3eEeSthWLzLvYIIqphviDe6V+5GdyCPdJnYhqSi/D8HUW8F9jCGRCoKhZ8nV8gIeKsHVokdKs4GBOpP4UbmRs4=" Aug 25 08:21:48 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:48+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 25 08:21:48 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:48+02:00" level=debug msg="completed keyexchange" Aug 25 08:21:48 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:48+02:00" level=debug msg="completed challenge" Aug 25 08:21:48 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:48+02:00" level=info msg="authenticated AP" username="mo*******nt" Aug 25 08:21:48 primo-jarrie go-librespot[13657]: time="2026-08-25T08:21:48+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 08:21:48 primo-jarrie systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 08:21:48 primo-jarrie systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 08:21:48 primo-jarrie volumio[13171]: info: Checking for updated MCU Firmware Aug 25 08:21:48 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 25 08:21:48 primo-jarrie volumio[13171]: error: Failed to retrieve informations for FW Update Aug 25 08:21:49 primo-jarrie volumio[13171]: info: Initializing connection to go-librespot Websocket Aug 25 08:21:49 primo-jarrie volumio[13171]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 08:21:51 primo-jarrie systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Aug 25 08:21:51 primo-jarrie systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 08:21:51 primo-jarrie systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 08:21:51 primo-jarrie go-librespot[13674]: go-librespot daemon starting... Aug 25 08:21:51 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:51+02:00" level=info msg="running go-librespot 0.7.1" Aug 25 08:21:51 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:51+02:00" level=debug msg="app state loaded" Aug 25 08:21:51 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:51+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 08:21:51 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:51+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 08:21:51 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:51+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 08:21:51 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:51+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 08:21:51 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:51+02:00" level=info msg="zeroconf server listening on port 37579" Aug 25 08:21:51 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:51+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 08:21:52 primo-jarrie volumio[13171]: info: Initializing connection to go-librespot Websocket Aug 25 08:21:52 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:52+02:00" level=debug msg="new websocket client" Aug 25 08:21:52 primo-jarrie volumio[13171]: info: Connection to go-librespot Websocket established Aug 25 08:21:52 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:52+02:00" level=debug msg="obtained new client token: AAEEpV7pksCPdmOq6UEnayvAI0/o+LTnVaQOFm/LivybSPw+FIz1yrZ1lX7XEh+MKdUJkrRZsgHUbdFXGdCpCG6LuS+RLbpP8/wWUsI5IPuFGPMEbFeTU6dKzR7q3FAgInhcPianUyZ7uSN6oiEoOC0R/q20uRVE9XB3LiLaJcjH+WERuIr/VajHWUV8UApgAKjxr6pB/4TdiGn2aji/VqgoM4vbWu/WsUbn3vpOSCuyikVrea8QhxA=" Aug 25 08:21:52 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:52+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 25 08:21:52 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:52+02:00" level=debug msg="completed keyexchange" Aug 25 08:21:52 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:52+02:00" level=debug msg="completed challenge" Aug 25 08:21:52 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:52+02:00" level=info msg="authenticated AP" username="mo*******nt" Aug 25 08:21:52 primo-jarrie go-librespot[13675]: time="2026-08-25T08:21:52+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 08:21:52 primo-jarrie systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 08:21:52 primo-jarrie systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 08:21:52 primo-jarrie volumio[13171]: info: Connection to go-librespot Websocket closed Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 25 08:21:52 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 25 08:21:53 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 25 08:21:53 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 25 08:21:53 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 08:21:53 primo-jarrie volumio[13171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 08:21:53 primo-jarrie volumio[13171]: info: Starting MyVolumio Remote Streaming Endpoints Aug 25 08:21:53 primo-jarrie volumio[13171]: info: MyVolumio login type: Token Aug 25 08:21:53 primo-jarrie volumio[13171]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 25 08:21:53 primo-jarrie volumio[13171]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json' Aug 25 08:21:54 primo-jarrie volumio[13171]: error: MyVolumio Custom Token format not valid, refreshing it Aug 25 08:21:54 primo-jarrie volumio[13171]: info: MyVolumio login type: Token Aug 25 08:21:55 primo-jarrie volumio[13171]: info: Getting Spotify volume Aug 25 08:21:55 primo-jarrie volumio[13171]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 08:21:55 primo-jarrie volumio[13171]: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 08:21:55 primo-jarrie volumio[13171]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Aug 25 08:21:55 primo-jarrie volumio[13171]: errno: -111, Aug 25 08:21:55 primo-jarrie volumio[13171]: code: 'ECONNREFUSED', Aug 25 08:21:55 primo-jarrie volumio[13171]: syscall: 'connect', Aug 25 08:21:55 primo-jarrie volumio[13171]: address: '127.0.0.1', Aug 25 08:21:55 primo-jarrie volumio[13171]: port: 9879, Aug 25 08:21:55 primo-jarrie volumio[13171]: response: undefined Aug 25 08:21:55 primo-jarrie volumio[13171]: } Aug 25 08:21:55 primo-jarrie volumio[13171]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 08:21:55 primo-jarrie systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Aug 25 08:21:55 primo-jarrie systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 08:21:55 primo-jarrie systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 08:21:55 primo-jarrie go-librespot[13708]: go-librespot daemon starting... Aug 25 08:21:55 primo-jarrie go-librespot[13710]: time="2026-08-25T08:21:55+02:00" level=info msg="running go-librespot 0.7.1" Aug 25 08:21:55 primo-jarrie go-librespot[13710]: time="2026-08-25T08:21:55+02:00" level=debug msg="app state loaded" Aug 25 08:21:55 primo-jarrie go-librespot[13710]: time="2026-08-25T08:21:55+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 08:21:55 primo-jarrie sudo[13725]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-25 08:20' Aug 25 08:21:55 primo-jarrie sudo[13725]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 08:21:55 primo-jarrie go-librespot[13710]: time="2026-08-25T08:21:55+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 08:21:55 primo-jarrie go-librespot[13710]: time="2026-08-25T08:21:55+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 08:21:55 primo-jarrie go-librespot[13710]: time="2026-08-25T08:21:55+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 08:21:55 primo-jarrie go-librespot[13710]: time="2026-08-25T08:21:55+02:00" level=info msg="zeroconf server listening on port 41763" Aug 25 08:21:55 primo-jarrie go-librespot[13710]: time="2026-08-25T08:21:55+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="9ccd1247f8cab3c5d64c23a96d243f6bfa34d032" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="9938d7179e3b7c4e41f3e2d60c255985cff08fee" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="primo2rev2" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun May 17 17:32:08 UTC 2026" VOLUMIO_VERSION="4.158" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Primo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Primo" VOLUMIO_HASH="43d420a3aa41c50690ebfe378df38e2b"