-- Logs begin at Thu 2025-09-04 06:38:25 +07, end at Thu 2025-09-04 16:10:32 +07. -- Sep 04 16:09:06 psaudio volumio[1202]: info: Volumio Network Manager: Network status updated: 2 Sep 04 16:09:07 psaudio volumio[1202]: info: Discovery: Disconnected from remote: 192.168.1.7 Sep 04 16:09:07 psaudio volumio[1202]: info: MRS: Cleaning up device: d6f9a5a1-926d-4508-8f02-55dc3f6db7e7 Sep 04 16:09:07 psaudio volumio[1202]: info: Removing audio output: Sep 04 16:09:07 psaudio ifplugd(eth0)[882]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Sep 04 16:09:07 psaudio dhcpcd[2570]: sending commands to master dhcpcd process Sep 04 16:09:07 psaudio ifplugd(eth0)[882]: client: sending commands to master dhcpcd process Sep 04 16:09:07 psaudio dhcpcd[658]: control command: /sbin/dhcpcd -k eth0 Sep 04 16:09:07 psaudio dhcpcd[658]: eth0: removing interface Sep 04 16:09:07 psaudio ifplugd(eth0)[882]: Program executed successfully. Sep 04 16:09:07 psaudio kernel: Generic FE-GE Realtek PHY r8169-0-100:00: attached PHY driver (mii_bus:phy_addr=r8169-0-100:00, irq=MAC) Sep 04 16:09:08 psaudio kernel: r8169 0000:01:00.0 eth0: Link is Down Sep 04 16:09:08 psaudio volumio[1202]: info: MRS: Pushing audio output on request Sep 04 16:09:08 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output Sep 04 16:09:08 psaudio volumio[1202]: info: Discovery: Connected to remote: 192.168.1.7 Sep 04 16:09:35 psaudio wpa_supplicant[979]: wlan0: CTRL-EVENT-BEACON-LOSS Sep 04 16:09:37 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:09:37 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:09:37 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:09:37 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:37 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:37 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:09:37 psaudio volumio[1202]: verbose: New Socket.io Connection to 192.168.1.2:3000 from 192.168.1.12 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Sep 04 16:09:37 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:37 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:37 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 04 16:09:37 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 04 16:09:37 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:37 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:38 psaudio sudo[2693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 16:09:38 psaudio sudo[2693]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:38 psaudio sudo[2693]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:38 psaudio sudo[2696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 16:09:38 psaudio sudo[2696]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:38 psaudio sudo[2696]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:38 psaudio volumio[1202]: verbose: New Socket.io Connection to 192.168.1.2 from 192.168.1.12 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Sep 04 16:09:38 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 16:09:39 psaudio sudo[2699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 16:09:39 psaudio sudo[2699]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:39 psaudio sudo[2699]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:39 psaudio sudo[2702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 16:09:39 psaudio sudo[2702]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:39 psaudio sudo[2702]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:39 psaudio volumio[1202]: verbose: New Socket.io Connection to 192.168.1.2 from 192.168.1.12 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:39 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 16:09:39 psaudio volumio[1202]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Sep 04 16:09:39 psaudio volumio[1202]: info: Received Get System Info Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:09:39 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:39 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:39 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:39 psaudio volumio[1202]: info: Listing playlists Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 04 16:09:39 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 04 16:09:40 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:09:40 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:09:40 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:09:40 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:40 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:40 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:09:40 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 04 16:09:41 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 16:09:41 psaudio volumio[1202]: info: Received Get System Info Sep 04 16:09:41 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:09:41 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:09:41 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:09:41 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:41 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:41 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:09:41 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 16:09:42 psaudio volumio[1202]: No protocol specified Sep 04 16:09:42 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 16:09:42 psaudio volumio[1202]: Invalid card number. Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 04 16:09:42 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 04 16:09:44 psaudio volumio[1202]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Sep 04 16:09:44 psaudio volumio[1202]: info: Preparing to save Alsa Options, stopping services first Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:44 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::volumioPause Sep 04 16:09:44 psaudio volumio[1202]: info: CoreStateMachine::pause Sep 04 16:09:44 psaudio volumio[1202]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"XMOS usb audio"}} Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 16:09:44 psaudio volumio[1202]: No protocol specified Sep 04 16:09:44 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:44 psaudio volumio[1202]: warn: Unable to locate the device XMOS usb audio a reboot may be required. Sep 04 16:09:44 psaudio volumio[1202]: No protocol specified Sep 04 16:09:44 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 16:09:44 psaudio volumio[1202]: Invalid card number. Sep 04 16:09:44 psaudio volumio[1202]: No protocol specified Sep 04 16:09:44 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 04 16:09:44 psaudio volumio[1202]: info: Updating Volume Controller Parameters: Device: 5 Name: XMOS usb audio Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 04 16:09:44 psaudio volumio[1202]: info: Disabling external Volume Control Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 16:09:44 psaudio volumio[1202]: info: Preparing to generate the ALSA configuration file Sep 04 16:09:44 psaudio volumio[1202]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Sep 04 16:09:44 psaudio volumio[1202]: info: Reading ALSA contributions from plugins. Sep 04 16:09:44 psaudio volumio[1202]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Sep 04 16:09:44 psaudio volumio[1202]: info: VolumeController:: Volume=undefined Mute =false Sep 04 16:09:44 psaudio volumio[1202]: info: CoreStateMachine::pushState Sep 04 16:09:44 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::volumioPushState Sep 04 16:09:44 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output update for this device Sep 04 16:09:44 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:44 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:44 psaudio volumio[1202]: No protocol specified Sep 04 16:09:44 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 16:09:44 psaudio volumio[1202]: Invalid card number. Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 04 16:09:44 psaudio volumio[1202]: info: VolumeController::SetAlsaVolume0 Sep 04 16:09:44 psaudio volumio[1202]: info: CoreStateMachine::pushState Sep 04 16:09:44 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::volumioPushState Sep 04 16:09:44 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output update for this device Sep 04 16:09:44 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:44 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:44 psaudio volumio[1202]: info: VolumeController::SetAlsaVolume0 Sep 04 16:09:44 psaudio volumio[1202]: info: CoreStateMachine::pushState Sep 04 16:09:44 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::volumioPushState Sep 04 16:09:44 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output update for this device Sep 04 16:09:44 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output Sep 04 16:09:44 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:44 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:44 psaudio volumio[1202]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Sep 04 16:09:44 psaudio volumio[1202]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Sep 04 16:09:45 psaudio volumio[1202]: info: Asound.conf file written Sep 04 16:09:45 psaudio sudo[2728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Sep 04 16:09:45 psaudio sudo[2728]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:45 psaudio sudo[2728]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:45 psaudio volumio[1202]: No protocol specified Sep 04 16:09:45 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:45 psaudio volumio[1202]: info: Output device has changed, restarting MPD Sep 04 16:09:45 psaudio sudo[2733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 16:09:45 psaudio sudo[2733]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:45 psaudio volumio[1202]: info: Output device has changed, restarting Shairport Sync Sep 04 16:09:45 psaudio sudo[2733]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:45 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:45 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 16:09:45 psaudio sudo[2736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 16:09:45 psaudio sudo[2736]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:45 psaudio systemd[1]: Stopping Music Player Daemon... Sep 04 16:09:45 psaudio volumio[1202]: No protocol specified Sep 04 16:09:45 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:45 psaudio volumio[1202]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 16:09:45 psaudio volumio[1202]: No protocol specified Sep 04 16:09:45 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:45 psaudio volumio[1202]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 04 16:09:45 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:45 psaudio systemd[1]: mpd.service: Succeeded. Sep 04 16:09:45 psaudio systemd[1]: Stopped Music Player Daemon. Sep 04 16:09:45 psaudio systemd[1]: Starting Music Player Daemon... Sep 04 16:09:45 psaudio volumio[1202]: info: QobuzConnect: setDeactiveState invoked Sep 04 16:09:45 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:45 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:45 psaudio vtcs[2182]: [2025-09-04 16:09:45.361] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Sep 04 16:09:45 psaudio vtcs[2182]: [2025-09-04 16:09:45.363] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=8 errorno=104 error=Connection reset by peer Sep 04 16:09:45 psaudio vtcs[2182]: [2025-09-04 16:09:45.363] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Sep 04 16:09:45 psaudio volumio[1202]: info: Output device has changed, restarting MPD Sep 04 16:09:45 psaudio sudo[2745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 16:09:45 psaudio sudo[2745]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:45 psaudio sudo[2741]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 16:09:45 psaudio sudo[2741]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:45 psaudio sudo[2741]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:45 psaudio systemd[1]: Stopping Volumio Tidal Connect Service... Sep 04 16:09:45 psaudio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Sep 04 16:09:45 psaudio systemd[1]: vtcs.service: Succeeded. Sep 04 16:09:45 psaudio systemd[1]: Stopped Volumio Tidal Connect Service. Sep 04 16:09:45 psaudio volumio[1202]: info: Output device has changed, restarting Shairport Sync Sep 04 16:09:45 psaudio sudo[2745]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:45 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:45 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 16:09:45 psaudio sudo[2752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 16:09:45 psaudio sudo[2752]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:45 psaudio sudo[2749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 16:09:45 psaudio sudo[2749]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:45 psaudio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 04 16:09:45 psaudio systemd[1]: mpd.service: Succeeded. Sep 04 16:09:45 psaudio systemd[1]: Stopped Music Player Daemon. Sep 04 16:09:45 psaudio sudo[2749]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:45 psaudio systemd[1]: Starting Music Player Daemon... Sep 04 16:09:45 psaudio volumio[1202]: No protocol specified Sep 04 16:09:45 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:45 psaudio volumio[1202]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 16:09:45 psaudio volumio[1202]: No protocol specified Sep 04 16:09:45 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:45 psaudio volumio[1202]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 04 16:09:45 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:45 psaudio volumio[1202]: info: QobuzConnect: setDeactiveState invoked Sep 04 16:09:45 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:45 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:45 psaudio sudo[2763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 16:09:45 psaudio sudo[2763]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:45 psaudio sudo[2759]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 16:09:45 psaudio sudo[2759]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:45 psaudio sudo[2759]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:45 psaudio sudo[2763]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:45 psaudio sudo[2770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 16:09:45 psaudio sudo[2768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 16:09:45 psaudio sudo[2768]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:45 psaudio sudo[2770]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:46 psaudio sudo[2770]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 16:09:46 psaudio sudo[2768]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 16:09:46 psaudio sudo[2780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Sep 04 16:09:46 psaudio sudo[2780]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 16:09:46 psaudio volumio[1202]: info: Received Get System Info Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:09:46 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:46 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:09:46 psaudio volumio[1202]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Sep 04 16:09:46 psaudio volumio[1202]: info: Preparing to save Alsa Options, stopping services first Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:46 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::volumioPause Sep 04 16:09:46 psaudio sudo[2785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Sep 04 16:09:46 psaudio volumio[1202]: info: CoreStateMachine::pause Sep 04 16:09:46 psaudio volumio[1202]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"XMOS usb audio"}} Sep 04 16:09:46 psaudio sudo[2785]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 16:09:46 psaudio sudo[2780]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:46 psaudio sudo[2785]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:46 psaudio sudo[2789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Sep 04 16:09:46 psaudio sudo[2789]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:46 psaudio sudo[2788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Sep 04 16:09:46 psaudio sudo[2788]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:46 psaudio qobuz-connect[2078]: 20250904 16:09:46.431 [2078.2078] INFO SampleApp: Stopping Local configuration server Sep 04 16:09:46 psaudio qobuz-connect[2078]: 20250904 16:09:46.442 [2078.2078] INFO SampleApp: shat down connection on UNIX socket Sep 04 16:09:46 psaudio systemd[1]: Stopping Volumio Qobuz Connect Service... Sep 04 16:09:46 psaudio systemd[1]: qobuz-connect.service: Succeeded. Sep 04 16:09:46 psaudio systemd[1]: Stopped Volumio Qobuz Connect Service. Sep 04 16:09:46 psaudio systemd[1]: Started Volumio Qobuz Connect Service. Sep 04 16:09:46 psaudio sudo[2789]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:46 psaudio sudo[2788]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:46 psaudio volumio[1202]: No protocol specified Sep 04 16:09:46 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:46 psaudio volumio[1202]: warn: Unable to locate the device XMOS usb audio a reboot may be required. Sep 04 16:09:46 psaudio volumio[1202]: No protocol specified Sep 04 16:09:46 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 16:09:46 psaudio volumio[1202]: Invalid card number. Sep 04 16:09:46 psaudio wpa_supplicant[979]: wlan0: CTRL-EVENT-BEACON-LOSS Sep 04 16:09:46 psaudio volumio[1202]: No protocol specified Sep 04 16:09:46 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 04 16:09:46 psaudio volumio[1202]: info: Updating Volume Controller Parameters: Device: 5 Name: XMOS usb audio Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 04 16:09:46 psaudio volumio[1202]: info: Disabling external Volume Control Sep 04 16:09:46 psaudio volumio[1202]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 16:09:46 psaudio volumio[1202]: info: Preparing to generate the ALSA configuration file Sep 04 16:09:46 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:46 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 16:09:46 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:46 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:46 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 16:09:46 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:46 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 16:09:46 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:46 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 16:09:47 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:47 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:47 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 16:09:47 psaudio volumio[1202]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Sep 04 16:09:47 psaudio volumio[1202]: info: MPD Permissions set Sep 04 16:09:47 psaudio volumio[1202]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Sep 04 16:09:47 psaudio volumio[1202]: info: MPD Permissions set Sep 04 16:09:47 psaudio volumio[1202]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Sep 04 16:09:47 psaudio volumio[1202]: info: Reading ALSA contributions from plugins. Sep 04 16:09:47 psaudio volumio[1202]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Sep 04 16:09:47 psaudio volumio[1202]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Sep 04 16:09:47 psaudio volumio[1202]: info: QobuzConnect: setDeactiveState invoked Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:47 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:47 psaudio volumio[1202]: info: Executing endpoint qc_getconfig Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Sep 04 16:09:47 psaudio qobuz-connect[2794]: 20250904 16:09:47.171 [2794.2794] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Sep 04 16:09:47 psaudio volumio[1202]: info: VolumeController:: Volume=undefined Mute =false Sep 04 16:09:47 psaudio volumio[1202]: info: CoreStateMachine::pushState Sep 04 16:09:47 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::volumioPushState Sep 04 16:09:47 psaudio qobuz-connect[2794]: 20250904 16:09:47.185 [2794.2794] INFO VolumeManager: [0x5600db2a8ff0]: Setting new playback volume: 75 Sep 04 16:09:47 psaudio qobuz-connect[2794]: 20250904 16:09:47.186 [2794.2794] INFO VolumeManager: [0x5600db2a8ff0]: Setting new mute state: 0 Sep 04 16:09:47 psaudio qobuz-connect[2794]: 20250904 16:09:47.186 [2794.2794] INFO QobuzConnect: [0x5600db2aa210]: Client initialized! Sep 04 16:09:47 psaudio qobuz-connect[2794]: 20250904 16:09:47.186 [2794.2794] INFO SampleApp: Starting Avahi advertising, name: PSAudio, service name: _qobuz-connect._tcp Sep 04 16:09:47 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output update for this device Sep 04 16:09:47 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:47 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:47 psaudio qobuz-connect[2794]: 20250904 16:09:47.232 [2794.2794] INFO LocalConfigManager: [0x5600db2a82e0]: Starting Local Configuration server Sep 04 16:09:47 psaudio qobuz-connect[2794]: 20250904 16:09:47.233 [2794.2794] INFO SampleApp: Starting Local configuration server Sep 04 16:09:47 psaudio qobuz-connect[2794]: 20250904 16:09:47.233 [2794.2794] INFO SampleApp: Connected to UNIX socket client 0x5600db290280 Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 04 16:09:47 psaudio qobuz-connect[2794]: 20250904 16:09:47.323 [2794.2794] INFO SampleApp: Playback volume changed: 75 Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Sep 04 16:09:47 psaudio volumio[1202]: info: QobuzConnect: QOBUZ Connect daemon connected Sep 04 16:09:47 psaudio volumio[1202]: No protocol specified Sep 04 16:09:47 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 16:09:47 psaudio volumio[1202]: Invalid card number. Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:47 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:47 psaudio volumio[1202]: info: Starting Shairport Sync Sep 04 16:09:47 psaudio volumio[1202]: info: Starting Shairport Sync Sep 04 16:09:47 psaudio mpd[2767]: Sep 04 16:09 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 04 16:09:47 psaudio sudo[2838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 16:09:47 psaudio sudo[2838]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:47 psaudio volumio[1202]: info: Asound.conf file unchanged, so no further update is needed Sep 04 16:09:47 psaudio volumio[1202]: info: Output device has changed, restarting MPD Sep 04 16:09:47 psaudio sudo[2841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 16:09:47 psaudio sudo[2841]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:47 psaudio systemd[1]: Started Music Player Daemon. Sep 04 16:09:47 psaudio sudo[2736]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:47 psaudio sudo[2752]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:47 psaudio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 16:09:47 psaudio systemd[1]: shairport-sync.service: Succeeded. Sep 04 16:09:47 psaudio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 16:09:47 psaudio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 16:09:47 psaudio sudo[2838]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:47 psaudio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 16:09:47 psaudio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Sep 04 16:09:47 psaudio systemd[1]: shairport-sync.service: Succeeded. Sep 04 16:09:47 psaudio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 16:09:47 psaudio volumio[1202]: info: Output device has changed, restarting Shairport Sync Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:47 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 16:09:47 psaudio sudo[2847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 16:09:47 psaudio sudo[2847]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:47 psaudio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 16:09:47 psaudio sudo[2841]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:47 psaudio sudo[2847]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:47 psaudio sudo[2851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 16:09:47 psaudio sudo[2851]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:48 psaudio systemd[1]: Stopping Music Player Daemon... Sep 04 16:09:48 psaudio systemd[1]: mpd.service: Succeeded. Sep 04 16:09:48 psaudio systemd[1]: Stopped Music Player Daemon. Sep 04 16:09:48 psaudio volumio[1202]: No protocol specified Sep 04 16:09:48 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:48 psaudio volumio[1202]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 16:09:48 psaudio volumio[1202]: No protocol specified Sep 04 16:09:48 psaudio volumio[1202]: xcb_connection_has_error() returned true Sep 04 16:09:48 psaudio volumio[1202]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Sep 04 16:09:48 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:48 psaudio systemd[1]: Starting Music Player Daemon... Sep 04 16:09:48 psaudio volumio[1202]: info: QobuzConnect: setDeactiveState invoked Sep 04 16:09:48 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:48 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:48 psaudio sudo[2863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 16:09:48 psaudio sudo[2863]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:48 psaudio sudo[2859]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 16:09:48 psaudio sudo[2859]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:48 psaudio sudo[2859]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:48 psaudio sudo[2863]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:48 psaudio sudo[2868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 16:09:48 psaudio sudo[2868]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:48 psaudio sudo[2868]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:48 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 16:09:48 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:48 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 16:09:48 psaudio sudo[2876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Sep 04 16:09:48 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:48 psaudio sudo[2876]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:48 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 16:09:48 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:48 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 16:09:48 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:48 psaudio sudo[2876]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:48 psaudio volumio[1202]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Sep 04 16:09:48 psaudio volumio[1202]: info: MPD Permissions set Sep 04 16:09:48 psaudio volumio[1202]: info: Shairport-Sync Started Sep 04 16:09:48 psaudio volumio[1202]: info: Shairport-Sync Started Sep 04 16:09:48 psaudio sudo[2878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Sep 04 16:09:48 psaudio sudo[2878]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:48 psaudio systemd[1]: Stopping Volumio Qobuz Connect Service... Sep 04 16:09:48 psaudio volumio[1202]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 04 16:09:48 psaudio volumio[1202]: info: CoreStateMachine::getcurrentVolume Sep 04 16:09:48 psaudio volumio[1202]: info: CoreCommandRouter::volumioRetrievevolume Sep 04 16:09:48 psaudio qobuz-connect[2794]: 20250904 16:09:48.685 [2794.2794] INFO SampleApp: Stopping Local configuration server Sep 04 16:09:48 psaudio qobuz-connect[2794]: 20250904 16:09:48.688 [2794.2794] INFO SampleApp: shat down connection on UNIX socket Sep 04 16:09:48 psaudio systemd[1]: qobuz-connect.service: Succeeded. Sep 04 16:09:48 psaudio systemd[1]: Stopped Volumio Qobuz Connect Service. Sep 04 16:09:48 psaudio systemd[1]: Started Volumio Qobuz Connect Service. Sep 04 16:09:48 psaudio sudo[2878]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:48 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:48 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 16:09:48 psaudio volumio[1202]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Sep 04 16:09:48 psaudio volumio[1202]: info: QobuzConnect: setDeactiveState invoked Sep 04 16:09:48 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:48 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:48 psaudio volumio[1202]: info: TidalConnect service stoped! Sep 04 16:09:48 psaudio volumio[1202]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 16:09:49 psaudio volumio[1202]: info: Executing endpoint qc_getconfig Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Sep 04 16:09:49 psaudio qobuz-connect[2880]: 20250904 16:09:49.187 [2880.2880] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Sep 04 16:09:49 psaudio volumio[1202]: info: TidalConnect service stoped! Sep 04 16:09:49 psaudio volumio[1202]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Sep 04 16:09:49 psaudio volumio[1202]: info: QobuzConnect: QOBUZ Connect daemon connected Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 16:09:49 psaudio qobuz-connect[2880]: 20250904 16:09:49.203 [2880.2880] INFO VolumeManager: [0x55766a8c1ff0]: Setting new playback volume: 75 Sep 04 16:09:49 psaudio qobuz-connect[2880]: 20250904 16:09:49.203 [2880.2880] INFO VolumeManager: [0x55766a8c1ff0]: Setting new mute state: 0 Sep 04 16:09:49 psaudio qobuz-connect[2880]: 20250904 16:09:49.203 [2880.2880] INFO QobuzConnect: [0x55766a8c3210]: Client initialized! Sep 04 16:09:49 psaudio qobuz-connect[2880]: 20250904 16:09:49.203 [2880.2880] INFO SampleApp: Starting Avahi advertising, name: PSAudio, service name: _qobuz-connect._tcp Sep 04 16:09:49 psaudio volumio[1202]: info: TidalConnect service stoped! Sep 04 16:09:49 psaudio qobuz-connect[2880]: 20250904 16:09:49.236 [2880.2880] INFO LocalConfigManager: [0x55766a8c12e0]: Starting Local Configuration server Sep 04 16:09:49 psaudio qobuz-connect[2880]: 20250904 16:09:49.236 [2880.2880] INFO SampleApp: Starting Local configuration server Sep 04 16:09:49 psaudio qobuz-connect[2880]: 20250904 16:09:49.237 [2880.2880] INFO SampleApp: Connected to UNIX socket client 0x55766a8a9280 Sep 04 16:09:49 psaudio volumio[1202]: info: TidalConnect service stoped! Sep 04 16:09:49 psaudio volumio[1202]: info: VolumeController:: Volume=undefined Mute =false Sep 04 16:09:49 psaudio volumio[1202]: info: CoreStateMachine::pushState Sep 04 16:09:49 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::volumioPushState Sep 04 16:09:49 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output update for this device Sep 04 16:09:49 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:49 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:49 psaudio qobuz-connect[2880]: 20250904 16:09:49.337 [2880.2880] INFO SampleApp: Playback volume changed: 75 Sep 04 16:09:49 psaudio volumio[1202]: info: CoreStateMachine::updateTrackBlock Sep 04 16:09:49 psaudio volumio[1202]: info: CorePlayQueue::getTrackBlock Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::volumioRetrievevolume Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:49 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:49 psaudio volumio[1202]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Sep 04 16:09:49 psaudio volumio[1202]: info: Starting Shairport Sync Sep 04 16:09:49 psaudio volumio[1202]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Sep 04 16:09:49 psaudio volumio[1202]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Sep 04 16:09:49 psaudio volumio[1202]: info: VolumeController:: Volume=undefined Mute =false Sep 04 16:09:49 psaudio volumio[1202]: info: CoreStateMachine::pushState Sep 04 16:09:49 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::volumioPushState Sep 04 16:09:49 psaudio sudo[2910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 16:09:49 psaudio sudo[2910]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:49 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output update for this device Sep 04 16:09:49 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output Sep 04 16:09:49 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:49 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:49 psaudio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 16:09:49 psaudio systemd[1]: shairport-sync.service: Succeeded. Sep 04 16:09:49 psaudio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 16:09:49 psaudio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 16:09:49 psaudio sudo[2910]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:49 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:09:49 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 04 16:09:49 psaudio volumio[1202]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Sep 04 16:09:49 psaudio volumio[1202]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Sep 04 16:09:49 psaudio volumio[1202]: info: Shairport-Sync Started Sep 04 16:09:49 psaudio sudo[2915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Sep 04 16:09:49 psaudio sudo[2915]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:50 psaudio systemd[1]: Started Volumio Tidal Connect Service. Sep 04 16:09:50 psaudio sudo[2915]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:50 psaudio sudo[2919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Sep 04 16:09:50 psaudio sudo[2919]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:50 psaudio sudo[2919]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:50 psaudio mpd[2867]: Sep 04 16:09 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 04 16:09:50 psaudio systemd[1]: Started Music Player Daemon. Sep 04 16:09:50 psaudio volumio[1202]: info: Executing endpoint tc_getconfig Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Sep 04 16:09:50 psaudio sudo[2851]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:50 psaudio vtcs[2920]: STARTING TidalConnect services, version: 1.5.1-beta1 Sep 04 16:09:50 psaudio vtcs[2920]: STARTED TidalConnect services. Sep 04 16:09:50 psaudio volumio[1202]: error: MPD error: The expression evaluated to a falsy value: Sep 04 16:09:50 psaudio volumio[1202]: assert.ok(self.idling) Sep 04 16:09:50 psaudio volumio[1202]: error: The expression evaluated to a falsy value: Sep 04 16:09:50 psaudio volumio[1202]: assert.ok(self.idling) Sep 04 16:09:50 psaudio volumio[1202]: error: updateQueue error: null Sep 04 16:09:50 psaudio volumio[1202]: info: Executing endpoint tc_connect Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Sep 04 16:09:50 psaudio volumio[1202]: info: Connecting to TidalConnect Sep 04 16:09:50 psaudio volumio[1202]: error: updateQueue error: null Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::servicePushState Sep 04 16:09:50 psaudio volumio[1202]: info: CoreStateMachine::pushState Sep 04 16:09:50 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::volumioPushState Sep 04 16:09:50 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output update for this device Sep 04 16:09:50 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:50 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:50 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:50 psaudio volumio[1202]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::servicePushState Sep 04 16:09:50 psaudio volumio[1202]: info: CoreStateMachine::pushState Sep 04 16:09:50 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::volumioPushState Sep 04 16:09:50 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output update for this device Sep 04 16:09:50 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:50 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:50 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:50 psaudio volumio[1202]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 04 16:09:50 psaudio volumio[1202]: info: CoreStateMachine::getcurrentVolume Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::volumioRetrievevolume Sep 04 16:09:50 psaudio volumio[1202]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Sep 04 16:09:50 psaudio volumio[1202]: info: VolumeController:: Volume=undefined Mute =false Sep 04 16:09:50 psaudio volumio[1202]: info: CoreStateMachine::pushState Sep 04 16:09:50 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::volumioPushState Sep 04 16:09:50 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output update for this device Sep 04 16:09:50 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:50 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:50 psaudio volumio[1202]: info: CoreStateMachine::updateTrackBlock Sep 04 16:09:50 psaudio volumio[1202]: info: CorePlayQueue::getTrackBlock Sep 04 16:09:50 psaudio volumio[1202]: info: CoreCommandRouter::volumioRetrievevolume Sep 04 16:09:51 psaudio volumio[1202]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Sep 04 16:09:51 psaudio volumio[1202]: info: VolumeController:: Volume=undefined Mute =false Sep 04 16:09:51 psaudio volumio[1202]: info: CoreStateMachine::pushState Sep 04 16:09:51 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:51 psaudio volumio[1202]: info: CoreCommandRouter::volumioPushState Sep 04 16:09:51 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output update for this device Sep 04 16:09:51 psaudio volumio[1202]: info: MRS: Pushing multiroomSync output Sep 04 16:09:51 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:51 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:51 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetQueue Sep 04 16:09:51 psaudio volumio[1202]: info: CoreStateMachine::getQueue Sep 04 16:09:51 psaudio volumio[1202]: info: CorePlayQueue::getQueue Sep 04 16:09:51 psaudio volumio[1202]: info: TidalConnect service stoped! Sep 04 16:09:51 psaudio volumio[1202]: info: TidalConnect service stoped! Sep 04 16:09:51 psaudio volumio[1202]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Sep 04 16:09:51 psaudio volumio[1202]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Sep 04 16:09:51 psaudio sudo[2956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Sep 04 16:09:51 psaudio sudo[2956]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:09:51 psaudio sudo[2956]: pam_unix(sudo:session): session closed for user root Sep 04 16:09:52 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 16:09:52 psaudio volumio[1202]: info: Preload queue cleared Sep 04 16:09:53 psaudio volumio[1202]: info: TidalConnect service started! Sep 04 16:09:53 psaudio volumio[1202]: info: TidalConnect service started! Sep 04 16:09:53 psaudio nmbd[866]: [2025/09/04 16:09:53.718051, 0] ../source3/libsmb/nmblib.c:917(send_udp) Sep 04 16:09:53 psaudio nmbd[866]: Packet send failed to 192.168.1.255(138) ERRNO=Network is unreachable Sep 04 16:09:54 psaudio volumio[1202]: info: TidalConnect service started! Sep 04 16:09:55 psaudio ntpd[1194]: Soliciting pool server 2400:e920:0:5::14 Sep 04 16:09:57 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 04 16:09:57 psaudio volumio[1202]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 04 16:09:57 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 04 16:09:57 psaudio volumio[1202]: info: Received Get System Version Sep 04 16:09:57 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 04 16:09:57 psaudio volumio[1202]: info: Received Get System Info Sep 04 16:09:57 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:09:57 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:09:57 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:09:57 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:09:57 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:09:57 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:10:05 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:05 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:10:05 psaudio sudo[2975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 16:10:05 psaudio sudo[2975]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:10:05 psaudio sudo[2975]: pam_unix(sudo:session): session closed for user root Sep 04 16:10:05 psaudio sudo[2978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 16:10:05 psaudio sudo[2978]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:10:05 psaudio sudo[2978]: pam_unix(sudo:session): session closed for user root Sep 04 16:10:05 psaudio volumio[1202]: verbose: New Socket.io Connection to 192.168.1.2 from 192.168.1.12 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Sep 04 16:10:05 psaudio volumio[1202]: info: Received Get System Info Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:10:05 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:05 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:05 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:05 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 16:10:05 psaudio volumio[1202]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Sep 04 16:10:05 psaudio volumio[1202]: info: Received Get System Info Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:10:05 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:05 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:05 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:05 psaudio volumio[1202]: info: Listing playlists Sep 04 16:10:05 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetQueue Sep 04 16:10:05 psaudio volumio[1202]: info: CoreStateMachine::getQueue Sep 04 16:10:05 psaudio volumio[1202]: info: CorePlayQueue::getQueue Sep 04 16:10:07 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 16:10:07 psaudio volumio[1202]: info: Received Get System Info Sep 04 16:10:07 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:10:07 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:10:07 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:10:07 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:07 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:07 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:10:07 psaudio wpa_supplicant[979]: wlan0: CTRL-EVENT-BEACON-LOSS Sep 04 16:10:12 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , myVolumioLogout Sep 04 16:10:12 psaudio volumio[1202]: info: [MyVolumio PluginManager] Subscribed plan changed to free Sep 04 16:10:12 psaudio volumio[1202]: info: [MyVolumio PluginManager] Device deactivated, disabling myvolumio plugins... Sep 04 16:10:12 psaudio volumio[1202]: info: ___________ STOPPING MYVOLUMIO PLUGINS ___________ Sep 04 16:10:12 psaudio volumio[1202]: info: Sep 04 16:10:12 psaudio volumio[1202]: info: Removing METAVOLUMIO REST API Endpoints Sep 04 16:10:12 psaudio volumio[1202]: info: Removing metavolumio REST Endpoint Sep 04 16:10:12 psaudio volumio[1202]: info: Removing getSimilarArtists REST Endpoint Sep 04 16:10:12 psaudio volumio[1202]: info: Removing getSimilarAlbums REST Endpoint Sep 04 16:10:12 psaudio volumio[1202]: info: Removing getSimilarTracks REST Endpoint Sep 04 16:10:12 psaudio volumio[1202]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Sep 04 16:10:12 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 16:10:12 psaudio volumio[1202]: Cannot find translation for source HD-Audio Generic Sep 04 16:10:12 psaudio volumio[1202]: Cannot find translation for source QOBUZ Sep 04 16:10:12 psaudio volumio[1202]: info: Stopping UDEV Watcher for CD Sep 04 16:10:12 psaudio volumio[1202]: info: Removeing all smart Inputs Sep 04 16:10:12 psaudio volumio[1202]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesHD-Audio Generic Sep 04 16:10:12 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 16:10:12 psaudio volumio[1202]: Cannot find translation for source QOBUZ Sep 04 16:10:12 psaudio volumio[1202]: info: Stopping AccessToken refresher cron Sep 04 16:10:12 psaudio sudo[2998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service Sep 04 16:10:12 psaudio sudo[2998]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:10:12 psaudio volumio[1202]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Sep 04 16:10:12 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 16:10:12 psaudio volumio[1202]: Cannot find translation for source QOBUZ Sep 04 16:10:12 psaudio volumio[1202]: info: Stopping AccessToken refresher cron for QOBUZ Sep 04 16:10:12 psaudio volumio[1202]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Sep 04 16:10:12 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 16:10:12 psaudio vtcs[2920]: [2025-09-04 16:10:12.552] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Sep 04 16:10:12 psaudio vtcs[2920]: [2025-09-04 16:10:12.554] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Sep 04 16:10:12 psaudio systemd[1]: Stopping Volumio Bluetooth Module... Sep 04 16:10:12 psaudio volumio[1202]: info: QobuzConnect: setDeactiveState invoked Sep 04 16:10:12 psaudio volumiobt[3000]: Killing pulse Sep 04 16:10:12 psaudio qobuz-connect[2880]: 20250904 16:10:12.601 [2880.2880] INFO MediaEngine: [0x55766a8c17f0]: Stopping playback, keeping tracks Sep 04 16:10:12 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:12 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:12 psaudio volumio[1202]: info: MyVolumio status changed Sep 04 16:10:12 psaudio volumio[1202]: info: Streaming services startup Sep 04 16:10:12 psaudio volumio[1202]: info: Starting Streaming Daemon Sep 04 16:10:12 psaudio volumiobt[3000]: Killing BT Pair agent Sep 04 16:10:12 psaudio sudo[3002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 04 16:10:12 psaudio sudo[3002]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:10:12 psaudio systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM Sep 04 16:10:12 psaudio systemd[1]: volumiobt.service: Succeeded. Sep 04 16:10:12 psaudio systemd[1]: Stopped Volumio Bluetooth Module. Sep 04 16:10:12 psaudio sudo[2998]: pam_unix(sudo:session): session closed for user root Sep 04 16:10:12 psaudio systemd[1]: Stopping Volumio Tidal Connect Service... Sep 04 16:10:12 psaudio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Sep 04 16:10:12 psaudio systemd[1]: vtcs.service: Succeeded. Sep 04 16:10:12 psaudio systemd[1]: Stopped Volumio Tidal Connect Service. Sep 04 16:10:12 psaudio sudo[3002]: pam_unix(sudo:session): session closed for user root Sep 04 16:10:12 psaudio sudo[3007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 04 16:10:12 psaudio sudo[3007]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:10:12 psaudio volumio[1202]: info: MYVOLUMIO LOGGED OUT Sep 04 16:10:12 psaudio volumio[1202]: info: Removing browser output: myVolumio user plan is not superstar Sep 04 16:10:12 psaudio volumio[1202]: info: Removing audio output: Sep 04 16:10:12 psaudio volumio[1202]: info: Stoppping Tunnel 1 Sep 04 16:10:12 psaudio sudo[3007]: pam_unix(sudo:session): session closed for user root Sep 04 16:10:12 psaudio sudo[3011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Sep 04 16:10:12 psaudio sudo[3011]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:10:12 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:10:12 psaudio systemd[1]: Stopping MyVolumio SSH Tunnel... Sep 04 16:10:12 psaudio autossh[2162]: received signal to exit (15) Sep 04 16:10:12 psaudio systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Sep 04 16:10:12 psaudio systemd[1]: sshtunnel.service: Succeeded. Sep 04 16:10:12 psaudio systemd[1]: Stopped MyVolumio SSH Tunnel. Sep 04 16:10:12 psaudio sudo[3014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop qobuz-connect Sep 04 16:10:12 psaudio sudo[3014]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:10:12 psaudio sudo[3011]: pam_unix(sudo:session): session closed for user root Sep 04 16:10:12 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:10:12 psaudio systemd[1]: Stopping Volumio Qobuz Connect Service... Sep 04 16:10:12 psaudio volumio[1202]: error: Cannot start Volumio Streaming Daemon Sep 04 16:10:12 psaudio volumio[1202]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 04 16:10:12 psaudio volumio[1202]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 04 16:10:12 psaudio qobuz-connect[2880]: 20250904 16:10:12.926 [2880.2880] INFO SampleApp: Stopping Local configuration server Sep 04 16:10:12 psaudio volumio[1202]: info: Volumio BT Module successfully stopped Sep 04 16:10:12 psaudio qobuz-connect[2880]: 20250904 16:10:12.936 [2880.2880] INFO SampleApp: shat down connection on UNIX socket Sep 04 16:10:12 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:10:12 psaudio systemd[1]: qobuz-connect.service: Succeeded. Sep 04 16:10:12 psaudio systemd[1]: Stopped Volumio Qobuz Connect Service. Sep 04 16:10:12 psaudio volumio[1202]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 04 16:10:12 psaudio volumio[1202]: info: Remote SSH Stopped Sep 04 16:10:12 psaudio sudo[3014]: pam_unix(sudo:session): session closed for user root Sep 04 16:10:12 psaudio volumio[1202]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Sep 04 16:10:12 psaudio volumio[1202]: info: QobuzConnect: setDeactiveState invoked Sep 04 16:10:12 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:12 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:12 psaudio volumio[1202]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket disconnected and tore down Sep 04 16:10:14 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 16:10:14 psaudio volumio[1202]: info: Received Get System Info Sep 04 16:10:14 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:10:14 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:10:14 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:10:14 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:14 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:14 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:10:14 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 16:10:14 psaudio volumio[1202]: info: Received Get System Info Sep 04 16:10:14 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:10:14 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:10:14 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:10:14 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:14 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:14 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:10:14 psaudio volumio[1202]: info: MyVolumio not started Sep 04 16:10:14 psaudio volumio[1202]: info: Initializing device activation check Sep 04 16:10:14 psaudio volumio[1202]: info: MyVolumio not started Sep 04 16:10:14 psaudio volumio[1202]: info: Initializing device activation check Sep 04 16:10:15 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 16:10:15 psaudio volumio[1202]: info: TidalConnect service stoped! Sep 04 16:10:16 psaudio sudo[3018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 16:10:16 psaudio sudo[3018]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:10:16 psaudio sudo[3018]: pam_unix(sudo:session): session closed for user root Sep 04 16:10:16 psaudio sudo[3021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 16:10:16 psaudio sudo[3021]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 16:10:16 psaudio sudo[3021]: pam_unix(sudo:session): session closed for user root Sep 04 16:10:16 psaudio volumio[1202]: verbose: New Socket.io Connection to 192.168.1.2 from 192.168.1.12 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Sep 04 16:10:16 psaudio volumio[1202]: info: Received Get System Info Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:10:16 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:16 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:16 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:16 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 16:10:16 psaudio volumio[1202]: info: Received Get System Info Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:10:16 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:16 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:16 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:16 psaudio volumio[1202]: info: Listing playlists Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetQueue Sep 04 16:10:16 psaudio volumio[1202]: info: CoreStateMachine::getQueue Sep 04 16:10:16 psaudio volumio[1202]: info: CorePlayQueue::getQueue Sep 04 16:10:16 psaudio volumio[1202]: info: Received Get System Info Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 16:10:16 psaudio volumio[1202]: info: Discovery: Getting this device information Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:16 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 16:10:16 psaudio volumio[1202]: info: CoreCommandRouter::volumioGetState Sep 04 16:10:16 psaudio volumio[1202]: info: CorePlayQueue::getTrack 0 Sep 04 16:10:20 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 16:10:20 psaudio volumio[1202]: info: Preload queue cleared Sep 04 16:10:21 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 16:10:21 psaudio volumio[1202]: info: Preload queue cleared Sep 04 16:10:23 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 16:10:24 psaudio volumio[1202]: info: Preload queue cleared Sep 04 16:10:25 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 16:10:25 psaudio volumio[1202]: info: Preload queue cleared Sep 04 16:10:26 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 16:10:26 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 16:10:27 psaudio volumio[1202]: info: Preload queue cleared Sep 04 16:10:31 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 16:10:31 psaudio volumio[1202]: info: Preload queue cleared Sep 04 16:10:32 psaudio volumio[1202]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 16:10:32 psaudio volumio[1202]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 16:10:32 psaudio volumio[1202]: TypeError: Cannot read property 'length' of undefined Sep 04 16:10:32 psaudio volumio[1202]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Sep 04 16:10:32 psaudio volumio[1202]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Sep 04 16:10:32 psaudio volumio[1202]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Sep 04 16:10:32 psaudio volumio[1202]: at Parser.emit (events.js:400:28) Sep 04 16:10:32 psaudio volumio[1202]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Sep 04 16:10:32 psaudio volumio[1202]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Sep 04 16:10:32 psaudio volumio[1202]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Sep 04 16:10:32 psaudio volumio[1202]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Sep 04 16:10:32 psaudio volumio[1202]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Sep 04 16:10:32 psaudio volumio[1202]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Sep 04 16:10:32 psaudio volumio[1202]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Sep 04 16:10:32 psaudio volumio[1202]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Sep 04 16:10:32 psaudio volumio[1202]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Sep 04 16:10:32 psaudio volumio[1202]: at IncomingMessage.emit (events.js:412:35) Sep 04 16:10:32 psaudio volumio[1202]: at endReadableNT (internal/streams/readable.js:1333:12) Sep 04 16:10:32 psaudio volumio[1202]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Sep 04 16:10:32 psaudio volumio[1202]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 16:10:32 psaudio sudo[3112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-04 16:09 Sep 04 16:10:32 psaudio sudo[3112]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"