Jun 26 23:02:48 volumio ntpd[772]: CLOCK: time stepped by 2306979.699629 Jun 26 23:02:48 volumio ntpd[772]: CLOCK: time changed from 2025-05-31 to 2025-06-26 Jun 26 23:02:48 volumio ntpd[772]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Jun 26 23:02:48 volumio systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Jun 26 23:02:48 volumio systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Jun 26 23:02:48 volumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Jun 26 23:02:48 volumio systemd[1]: e2scrub_all.service: Deactivated successfully. Jun 26 23:02:48 volumio systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Jun 26 23:02:48 volumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Jun 26 23:02:49 volumio systemd[1]: dpkg-db-backup.service: Deactivated successfully. Jun 26 23:02:49 volumio systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Jun 26 23:02:50 volumio nmbd[917]: [2025/06/26 23:02:50.355627, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 26 23:02:50 volumio nmbd[917]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Jun 26 23:02:50 volumio nmbd[917]: [2025/06/26 23:02:50.356466, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 26 23:02:50 volumio nmbd[917]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Jun 26 23:02:50 volumio nmbd[917]: [2025/06/26 23:02:50.356803, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 26 23:02:50 volumio nmbd[917]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 26 23:02:50 volumio nmbd[917]: [2025/06/26 23:02:50.356972, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 26 23:02:50 volumio nmbd[917]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 26 23:02:50 volumio nmbd[917]: [2025/06/26 23:02:50.357152, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 26 23:02:50 volumio nmbd[917]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 26 23:02:50 volumio nmbd[917]: [2025/06/26 23:02:50.357295, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 26 23:02:50 volumio nmbd[917]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 26 23:02:50 volumio nmbd[917]: [2025/06/26 23:02:50.357448, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 26 23:02:50 volumio nmbd[917]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 26 23:02:50 volumio nmbd[917]: [2025/06/26 23:02:50.357584, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 26 23:02:50 volumio nmbd[917]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 26 23:02:50 volumio nmbd[917]: [2025/06/26 23:02:50.357738, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 26 23:02:50 volumio nmbd[917]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 26 23:02:50 volumio nmbd[917]: [2025/06/26 23:02:50.357880, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 26 23:02:50 volumio nmbd[917]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 26 23:02:50 volumio nmbd[917]: [2025/06/26 23:02:50.358033, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 26 23:02:50 volumio nmbd[917]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 26 23:02:50 volumio nmbd[917]: [2025/06/26 23:02:50.358171, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 26 23:02:50 volumio nmbd[917]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 26 23:02:50 volumio volumio[996]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 26 23:02:50 volumio volumio[996]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 26 23:02:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 23:02:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 23:02:50 volumio volumio[996]: info: Starting MyVolumio Remote Streaming Endpoints Jun 26 23:02:50 volumio volumio[996]: info: MyVolumio not started Jun 26 23:02:50 volumio volumio[996]: info: Initializing device activation check Jun 26 23:02:51 volumio volumio[996]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 26 23:02:51 volumio volumio[996]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 26 23:02:52 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 26 23:02:54 volumio nmbd[917]: [2025/06/26 23:02:54.141814, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 26 23:02:54 volumio nmbd[917]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Jun 26 23:02:56 volumio volumio[996]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 26 23:02:56 volumio volumio[996]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 26 23:02:56 volumio volumio[996]: info: Streaming services startup Jun 26 23:02:56 volumio volumio[996]: info: Starting Streaming Daemon Jun 26 23:02:56 volumio sudo[2608]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 26 23:02:56 volumio sudo[2608]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 26 23:02:56 volumio volumio[996]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 26 23:02:56 volumio sudo[2608]: pam_unix(sudo:session): session closed for user root Jun 26 23:02:56 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Jun 26 23:02:56 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Jun 26 23:02:56 volumio volumio[996]: info: Discovery: Started advertising with name: Volumio Jun 26 23:02:57 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Jun 26 23:02:57 volumio sudo[2615]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 26 23:02:57 volumio sudo[2615]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 26 23:02:57 volumio sudo[2615]: pam_unix(sudo:session): session closed for user root Jun 26 23:02:57 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Jun 26 23:02:57 volumio volumio[996]: info: Refreshing Cached IP Addresses Jun 26 23:02:57 volumio volumio[996]: info: Volumio Network Manager: Network status updated: 2 Jun 26 23:02:57 volumio volumio[996]: info: MPD Database updated - AlbumList cache refreshed Jun 26 23:02:57 volumio volumio[996]: info: Jun 26 23:02:57 volumio volumio[996]: ---------------------------- MPD announces state update: database Jun 26 23:02:57 volumio sudo[2620]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 26 23:02:57 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status Jun 26 23:02:57 volumio volumio[996]: info: Jun 26 23:02:57 volumio volumio[996]: ---------------------------- MPD announces state update: update Jun 26 23:02:57 volumio volumio[996]: info: ControllerMpd::getState Jun 26 23:02:57 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status Jun 26 23:02:57 volumio volumio[996]: info: ControllerMpd::getState Jun 26 23:02:57 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status Jun 26 23:02:57 volumio volumio[996]: info: MPD Database updated - AlbumList cache refreshed Jun 26 23:02:57 volumio volumio[996]: info: Jun 26 23:02:57 volumio volumio[996]: ---------------------------- MPD announces state update: database Jun 26 23:02:57 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status Jun 26 23:02:57 volumio volumio[996]: info: Jun 26 23:02:57 volumio volumio[996]: ---------------------------- MPD announces state update: update Jun 26 23:02:57 volumio volumio[996]: info: ControllerMpd::getState Jun 26 23:02:57 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status Jun 26 23:02:57 volumio volumio[996]: info: ControllerMpd::getState Jun 26 23:02:57 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status Jun 26 23:02:57 volumio sudo[2620]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 26 23:02:57 volumio sudo[2620]: pam_unix(sudo:session): session closed for user root Jun 26 23:02:57 volumio sudo[2621]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Jun 26 23:02:57 volumio sudo[2621]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 26 23:02:57 volumio sudo[2621]: pam_unix(sudo:session): session closed for user root Jun 26 23:02:57 volumio sudo[2623]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 26 23:02:57 volumio sudo[2623]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 26 23:02:57 volumio sudo[2623]: pam_unix(sudo:session): session closed for user root Jun 26 23:02:57 volumio sudo[2629]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 26 23:02:57 volumio sudo[2629]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 26 23:02:57 volumio sudo[2629]: pam_unix(sudo:session): session closed for user root Jun 26 23:02:57 volumio volumio[996]: error: Cannot start Volumio Streaming Daemon Jun 26 23:02:57 volumio volumio[996]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 26 23:02:57 volumio volumio[996]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 26 23:02:57 volumio volumio[996]: info: sendMpdCommand status took 452 milliseconds Jun 26 23:02:57 volumio volumio[996]: info: sendMpdCommand status took 445 milliseconds Jun 26 23:02:57 volumio volumio[996]: info: sendMpdCommand status took 444 milliseconds Jun 26 23:02:57 volumio volumio[996]: verbose: ControllerMpd::parseState Jun 26 23:02:57 volumio volumio[996]: info: Command Router : Notfying DB Updatefalse Jun 26 23:02:57 volumio volumio[996]: info: CoreCommandRouter::Close All Modals sent Jun 26 23:02:57 volumio volumio[996]: verbose: ControllerMpd::parseState Jun 26 23:02:57 volumio volumio[996]: verbose: ControllerMpd::parseState Jun 26 23:02:57 volumio volumio[996]: info: ControllerMpd::pushState Jun 26 23:02:57 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jun 26 23:02:57 volumio volumio[996]: info: CoreStateMachine::pushState Jun 26 23:02:57 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:57 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jun 26 23:02:57 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:57 volumio volumio[996]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 26 23:02:57 volumio volumio[996]: verbose: CURRENT POSITION 0 Jun 26 23:02:57 volumio volumio[996]: info: CoreStateMachine::syncState stateService stop Jun 26 23:02:57 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus stop Jun 26 23:02:57 volumio volumio[996]: info: CoreStateMachine::pushState Jun 26 23:02:57 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:57 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jun 26 23:02:57 volumio volumio[996]: info: No code Jun 26 23:02:57 volumio volumio[996]: info: CoreStateMachine::pushState Jun 26 23:02:57 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:57 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jun 26 23:02:57 volumio volumio[996]: info: ControllerMpd::pushState Jun 26 23:02:57 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jun 26 23:02:57 volumio volumio[996]: info: CoreStateMachine::pushState Jun 26 23:02:57 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:57 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jun 26 23:02:57 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:57 volumio volumio[996]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 26 23:02:57 volumio volumio[996]: verbose: CURRENT POSITION 0 Jun 26 23:02:57 volumio volumio[996]: info: CoreStateMachine::syncState stateService stop Jun 26 23:02:57 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus stop Jun 26 23:02:57 volumio volumio[996]: info: CoreStateMachine::pushState Jun 26 23:02:57 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:57 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jun 26 23:02:57 volumio volumio[996]: info: No code Jun 26 23:02:57 volumio volumio[996]: info: CoreStateMachine::pushState Jun 26 23:02:57 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:57 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jun 26 23:02:58 volumio volumio[996]: info: ------------------------------ 743ms Jun 26 23:02:58 volumio volumio[996]: info: ------------------------------ 736ms Jun 26 23:02:58 volumio volumio[996]: info: sendMpdCommand status took 774 milliseconds Jun 26 23:02:58 volumio volumio[996]: info: sendMpdCommand status took 756 milliseconds Jun 26 23:02:58 volumio volumio[996]: info: sendMpdCommand status took 753 milliseconds Jun 26 23:02:58 volumio volumio[996]: verbose: ControllerMpd::parseState Jun 26 23:02:58 volumio volumio[996]: info: Command Router : Notfying DB Updatefalse Jun 26 23:02:58 volumio volumio[996]: info: CoreCommandRouter::Close All Modals sent Jun 26 23:02:58 volumio volumio[996]: verbose: ControllerMpd::parseState Jun 26 23:02:58 volumio volumio[996]: verbose: ControllerMpd::parseState Jun 26 23:02:58 volumio volumio[996]: info: ControllerMpd::pushState Jun 26 23:02:58 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jun 26 23:02:58 volumio volumio[996]: info: CoreStateMachine::pushState Jun 26 23:02:58 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:58 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jun 26 23:02:58 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:58 volumio volumio[996]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 26 23:02:58 volumio volumio[996]: verbose: CURRENT POSITION 0 Jun 26 23:02:58 volumio volumio[996]: info: CoreStateMachine::syncState stateService stop Jun 26 23:02:58 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus stop Jun 26 23:02:58 volumio volumio[996]: info: CoreStateMachine::pushState Jun 26 23:02:58 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:58 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jun 26 23:02:58 volumio volumio[996]: info: No code Jun 26 23:02:58 volumio volumio[996]: info: CoreStateMachine::pushState Jun 26 23:02:58 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:58 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jun 26 23:02:58 volumio volumio[996]: info: ControllerMpd::pushState Jun 26 23:02:58 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jun 26 23:02:58 volumio volumio[996]: info: CoreStateMachine::pushState Jun 26 23:02:58 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:58 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jun 26 23:02:58 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:58 volumio volumio[996]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 26 23:02:58 volumio volumio[996]: verbose: CURRENT POSITION 0 Jun 26 23:02:58 volumio volumio[996]: info: CoreStateMachine::syncState stateService stop Jun 26 23:02:58 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus stop Jun 26 23:02:58 volumio volumio[996]: info: CoreStateMachine::pushState Jun 26 23:02:58 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:58 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jun 26 23:02:58 volumio volumio[996]: info: No code Jun 26 23:02:58 volumio volumio[996]: info: CoreStateMachine::pushState Jun 26 23:02:58 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:58 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jun 26 23:02:58 volumio volumio[996]: info: ------------------------------ 883ms Jun 26 23:02:58 volumio volumio[996]: info: ------------------------------ 877ms Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 26 23:02:59 volumio volumio[996]: info: Discovery: Getting this device information Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Jun 26 23:02:59 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 26 23:02:59 volumio volumio[996]: verbose: New Socket.io Connection to 192.168.52.155:3000 from 192.168.52.87 UA: Dalvik/2.1.0 (Linux; U; Android 15; 23117RA68G Build/AP3A.240905.015.A2) Engine version: 3 Transport: polling Total Clients: 3 Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::volumioGetQueue Jun 26 23:02:59 volumio volumio[996]: info: CoreStateMachine::getQueue Jun 26 23:02:59 volumio volumio[996]: info: CorePlayQueue::getQueue Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Jun 26 23:02:59 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Jun 26 23:02:59 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Jun 26 23:02:59 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Jun 26 23:02:59 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::volumioGetVisibleSources Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 26 23:02:59 volumio volumio[996]: info: Getting Alsa Cards List without I2S DAC Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 26 23:02:59 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 26 23:03:02 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 26 23:03:02 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 26 23:03:04 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 26 23:03:05 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 26 23:03:05 volumio volumio[996]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 26 23:03:05 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Jun 26 23:03:05 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jun 26 23:03:07 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 26 23:03:07 volumio volumio[996]: info: Getting webradio selection Jun 26 23:03:08 volumio sudo[2669]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 26 23:03:08 volumio sudo[2669]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 26 23:03:08 volumio sudo[2671]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 26 23:03:08 volumio sudo[2671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 26 23:03:08 volumio sudo[2669]: pam_unix(sudo:session): session closed for user root Jun 26 23:03:08 volumio sudo[2671]: pam_unix(sudo:session): session closed for user root Jun 26 23:03:08 volumio sudo[2673]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 26 23:03:08 volumio sudo[2673]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 26 23:03:08 volumio sudo[2673]: pam_unix(sudo:session): session closed for user root Jun 26 23:03:08 volumio volumio[996]: info: Upmpdcli Daemon Started Jun 26 23:03:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 23:03:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 23:03:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 26 23:03:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 26 23:03:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 26 23:03:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 26 23:03:10 volumio volumio[996]: info: CoreCommandRouter::volumioGetBrowseSources Jun 26 23:03:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 26 23:03:33 volumio kernel: hwmon hwmon1: Voltage normalised Jun 26 23:03:33 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 26 23:03:33 volumio dbus-daemon[558]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.43' (uid=0 pid=2710 comm="timedatectl show --property=NTPSynchronized --valu") Jun 26 23:03:33 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 26 23:03:34 volumio dbus-daemon[558]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 26 23:03:34 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 26 23:03:34 volumio setdatetime-helper.sh[2708]: Time is not synchronized. Attempting to sync... Jun 26 23:03:34 volumio sudo[2718]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Thu, 26 Jun 2025 21:03:34 GMT#015' Jun 26 23:03:34 volumio sudo[2718]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 26 23:03:34 volumio setdatetime-helper.sh[2719]: Thu Jun 26 23:03:34 CEST 2025 Jun 26 23:03:34 volumio systemd-journald[363]: Time jumped backwards, rotating. Jun 26 23:03:34 volumio sudo[2718]: pam_unix(sudo:session): session closed for user root Jun 26 23:03:34 volumio setdatetime-helper.sh[2708]: Time synchronized successfully. Jun 26 23:03:34 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 26 23:03:34 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 26 23:03:34 volumio systemd[1]: Starting apt-daily.service - Daily apt download activities... Jun 26 23:03:35 volumio kernel: hwmon hwmon1: Undervoltage detected! Jun 26 23:03:36 volumio systemd[1]: apt-daily.service: Deactivated successfully. Jun 26 23:03:36 volumio systemd[1]: Finished apt-daily.service - Daily apt download activities. Jun 26 23:03:36 volumio systemd[1]: apt-daily.service: Consumed 1.649s CPU time. Jun 26 23:03:39 volumio kernel: hwmon hwmon1: Voltage normalised Jun 26 23:03:41 volumio volumio[996]: Searching all installed plugins Jun 26 23:03:41 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 26 23:03:41 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: , search Jun 26 23:03:41 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 26 23:03:41 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jun 26 23:03:41 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jun 26 23:03:41 volumio volumio[996]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jun 26 23:03:41 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jun 26 23:03:41 volumio volumio[996]: Use XMLElement.setAttribute instead Jun 26 23:03:41 volumio volumio[996]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 26 23:03:41 volumio volumio[996]: TypeError: children[i].attr(...).value is not a function Jun 26 23:03:41 volumio volumio[996]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 Jun 26 23:03:41 volumio volumio[996]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jun 26 23:03:41 volumio volumio[996]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 26 23:03:42 volumio sudo[2807]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-26 23:02' Jun 26 23:03:42 volumio sudo[2807]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4a70cb031e64a8e498efc3e29470650871ff7d54" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat May 31 04:09:10 UTC 2025" VOLUMIO_VERSION="4.005" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f9bd4447a30d4b2c74b3880e7a50e48b"