-- Logs begin at Mon 2025-04-28 15:20:34 EEST, end at Mon 2025-04-28 17:23:31 EEST. -- Apr 28 17:22:01 volumio volumio[881]: info: CoreCommandRouter::volumioGetState Apr 28 17:22:01 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:22:01 volumio volumio[881]: info: Listing playlists Apr 28 17:22:01 volumio volumio[881]: info: Listing playlists Apr 28 17:22:07 volumio volumio[881]: info: Airplay started streaming, receiving metadatas Apr 28 17:22:07 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:22:07 volumio volumio[881]: info: CoreCommandRouter::volumioStop Apr 28 17:22:07 volumio volumio[881]: info: CoreStateMachine::stop Apr 28 17:22:07 volumio volumio[881]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 17:22:07 volumio volumio[881]: info: Airplay started streaming, receiving metadatas Apr 28 17:22:07 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:22:07 volumio volumio[881]: info: CoreCommandRouter::volumioStop Apr 28 17:22:07 volumio volumio[881]: info: CoreStateMachine::stop Apr 28 17:22:07 volumio volumio[881]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 17:22:07 volumio volumio[881]: info: Airplay started streaming, receiving metadatas Apr 28 17:22:07 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:22:07 volumio volumio[881]: info: CoreCommandRouter::volumioStop Apr 28 17:22:07 volumio volumio[881]: info: CoreStateMachine::stop Apr 28 17:22:07 volumio volumio[881]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 17:22:07 volumio shairport-sync[1434]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 28 17:22:07 volumio shairport-sync[1434]: Dload Upload Total Spent Left Speed Apr 28 17:22:07 volumio volumio[881]: info: Apr 28 17:22:07 volumio volumio[881]: ---------------------------- Client requests Start Airplay PlaybackRoutine Apr 28 17:22:07 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Apr 28 17:22:07 volumio volumio[881]: info: Airplay playback start Apr 28 17:22:07 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:22:07 volumio volumio[881]: info: CoreCommandRouter::volumioStop Apr 28 17:22:07 volumio volumio[881]: info: CoreStateMachine::stop Apr 28 17:22:07 volumio volumio[881]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 17:22:07 volumio volumio[881]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 17:22:07 volumio shairport-sync[1434]: [158B blob data] Apr 28 17:22:07 volumio volumio[881]: info: Updating volume from AirPlay: -144; mute% Apr 28 17:22:07 volumio volumio[881]: info: VolumeController::SetAlsaVolumemute Apr 28 17:22:07 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:07 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:22:07 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 17:22:07 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:08 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:08 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:08 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 17:22:08 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:08 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:08 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:08 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:08 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:08 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:08 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:08 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:08 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:08 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:11 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:11 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:11 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:11 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:11 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:11 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:11 volumio volumio[881]: info: CoreCommandRouter::volumioGetState Apr 28 17:22:16 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:16 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:16 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 17:22:16 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:16 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:16 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:16 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:16 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:16 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:16 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:21 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:21 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:21 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 17:22:21 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:21 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:21 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:21 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:21 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:21 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:21 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:21 volumio volumio[881]: info: CoreCommandRouter::volumioGetState Apr 28 17:22:21 volumio volumio[881]: info: Listing playlists Apr 28 17:22:21 volumio volumio[881]: info: Listing playlists Apr 28 17:22:26 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:26 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:26 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 17:22:26 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:26 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:26 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:26 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:26 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:26 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:26 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:31 volumio volumio[881]: info: CoreCommandRouter::volumioGetState Apr 28 17:22:32 volumio nmbd[830]: [2025/04/28 17:22:32.488650, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 28 17:22:32 volumio nmbd[830]: query_name_response: Multiple (2) responses received for a query on subnet 10.13.10.15 for name WORKGROUP<1d>. Apr 28 17:22:32 volumio nmbd[830]: This response was from IP 10.13.8.10, reporting an IP address of 10.13.8.10. Apr 28 17:22:33 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:33 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:33 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 17:22:33 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:33 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:33 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:33 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:33 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:33 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:33 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:38 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:38 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:38 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 17:22:38 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:38 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:38 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:38 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:38 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:38 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:38 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:41 volumio volumio[881]: info: CoreCommandRouter::volumioGetState Apr 28 17:22:41 volumio volumio[881]: info: Listing playlists Apr 28 17:22:41 volumio volumio[881]: info: Listing playlists Apr 28 17:22:46 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:46 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:46 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 17:22:46 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:46 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:46 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:46 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:46 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:22:46 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:46 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:46 volumio shairport-sync[1434]: {"time":1745850127301,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Apr 28 17:22:46 volumio shairport-sync[1434]: Dload Upload Total Spent Left Speed Apr 28 17:22:46 volumio volumio[881]: info: Apr 28 17:22:46 volumio volumio[881]: ---------------------------- Client requests Stop Airplay Playback Apr 28 17:22:46 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Apr 28 17:22:46 volumio volumio[881]: info: Airplay playback stop Apr 28 17:22:46 volumio volumio[881]: info: Airplay Playback Stopped, clearing state Apr 28 17:22:46 volumio volumio[881]: info: CoreStateMachine::resetVolumioState Apr 28 17:22:46 volumio volumio[881]: info: CoreStateMachine::getcurrentVolume Apr 28 17:22:46 volumio volumio[881]: info: CoreCommandRouter::volumioRetrievevolume Apr 28 17:22:46 volumio shairport-sync[1434]: [158B blob data] Apr 28 17:22:46 volumio volumio[881]: info: VolumeController:: Volume=39 Mute =true Apr 28 17:22:46 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:46 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:46 volumio volumio[881]: info: CoreStateMachine::updateTrackBlock Apr 28 17:22:46 volumio volumio[881]: info: CorePlayQueue::getTrackBlock Apr 28 17:22:46 volumio volumio[881]: info: CoreCommandRouter::volumioRetrievevolume Apr 28 17:22:46 volumio volumio[881]: info: VolumeController:: Volume=39 Mute =true Apr 28 17:22:46 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:22:46 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:22:51 volumio volumio[881]: info: CoreCommandRouter::volumioGetState Apr 28 17:23:01 volumio volumio[881]: info: CoreCommandRouter::volumioGetState Apr 28 17:23:01 volumio volumio[881]: info: Listing playlists Apr 28 17:23:01 volumio volumio[881]: info: Listing playlists Apr 28 17:23:11 volumio volumio[881]: info: CoreCommandRouter::volumioGetState Apr 28 17:23:21 volumio volumio[881]: info: CoreCommandRouter::volumioGetState Apr 28 17:23:21 volumio volumio[881]: info: Listing playlists Apr 28 17:23:21 volumio volumio[881]: info: Listing playlists Apr 28 17:23:26 volumio volumio[881]: info: Clearing queue after UPNP request Apr 28 17:23:26 volumio volumio[881]: verbose: UNSET VOLATILE: Service: airplay_emulation Apr 28 17:23:26 volumio volumio[881]: info: Stopping Airplay Playback and sending pause command to client via USR2 Apr 28 17:23:26 volumio sudo[27381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 1434 Apr 28 17:23:26 volumio sudo[27381]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:23:26 volumio sudo[27381]: pam_unix(sudo:session): session closed for user root Apr 28 17:23:26 volumio volumio[881]: info: Shairport-Sync paused with USR2 Apr 28 17:23:26 volumio volumio[881]: info: CoreStateMachine::ClearQueue Apr 28 17:23:26 volumio volumio[881]: info: CoreStateMachine::stop Apr 28 17:23:26 volumio volumio[881]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 17:23:26 volumio volumio[881]: info: CorePlayQueue::clearPlayQueue Apr 28 17:23:26 volumio volumio[881]: info: CorePlayQueue::saveQueue Apr 28 17:23:26 volumio volumio[881]: info: CoreCommandRouter::volumioPushState Apr 28 17:23:26 volumio volumio[881]: info: CoreCommandRouter::volumioPushQueue Apr 28 17:23:26 volumio volumio[881]: error: Upnp client error: Error: This socket has been ended by the other party Apr 28 17:23:27 volumio volumio[881]: info: Restarting Shairport-Sync after stop Apr 28 17:23:27 volumio sudo[27386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 28 17:23:27 volumio sudo[27386]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:23:27 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 28 17:23:27 volumio shairport-sync[1434]: {"time":1745850166780,"response":"stopAirplayPlayback Success"} Apr 28 17:23:27 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 28 17:23:27 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 28 17:23:27 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 28 17:23:27 volumio sudo[27386]: pam_unix(sudo:session): session closed for user root Apr 28 17:23:27 volumio volumio[881]: info: Shairport-Sync retarted Apr 28 17:23:28 volumio volumio[881]: info: Starting UPNP Playback Apr 28 17:23:28 volumio volumio[881]: info: Preparing playback through UPNP Apr 28 17:23:28 volumio volumio[881]: info: CoreCommandRouter::volumioGetState Apr 28 17:23:28 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:23:28 volumio volumio[881]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 3ms Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 2ms Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 0ms Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 0ms Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: Apr 28 17:23:28 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:28 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:28 volumio volumio[881]: info: ------------------------------ 1ms Apr 28 17:23:30 volumio volumio[881]: info: Apr 28 17:23:30 volumio volumio[881]: ---------------------------- MPD announces state update: player Apr 28 17:23:30 volumio volumio[881]: info: ControllerMpd::getState Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 28 17:23:30 volumio volumio[881]: info: Apr 28 17:23:30 volumio volumio[881]: ---------------------------- MPD announces state update: player Apr 28 17:23:30 volumio volumio[881]: info: ControllerMpd::getState Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 28 17:23:30 volumio volumio[881]: info: Apr 28 17:23:30 volumio volumio[881]: ---------------------------- MPD announces state update: player Apr 28 17:23:30 volumio volumio[881]: info: ControllerMpd::getState Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 28 17:23:30 volumio volumio[881]: info: Apr 28 17:23:30 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:30 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:30 volumio volumio[881]: info: Apr 28 17:23:30 volumio volumio[881]: ---------------------------- MPD announces state update: player Apr 28 17:23:30 volumio volumio[881]: info: sendMpdCommand status took 36 milliseconds Apr 28 17:23:30 volumio volumio[881]: info: sendMpdCommand status took 35 milliseconds Apr 28 17:23:30 volumio volumio[881]: info: sendMpdCommand status took 35 milliseconds Apr 28 17:23:30 volumio volumio[881]: info: ControllerMpd::getState Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 17:23:30 volumio volumio[881]: info: Apr 28 17:23:30 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:30 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:30 volumio volumio[881]: info: Apr 28 17:23:30 volumio volumio[881]: ---------------------------- MPD announces state update: player Apr 28 17:23:30 volumio volumio[881]: info: ControllerMpd::getState Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 28 17:23:30 volumio volumio[881]: info: Apr 28 17:23:30 volumio volumio[881]: ---------------------------- MPD announces system playlist update Apr 28 17:23:30 volumio volumio[881]: info: Ignoring MPD Status Update Apr 28 17:23:30 volumio volumio[881]: info: Apr 28 17:23:30 volumio volumio[881]: ---------------------------- MPD announces state update: player Apr 28 17:23:30 volumio volumio[881]: info: ControllerMpd::getState Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand status Apr 28 17:23:30 volumio volumio[881]: info: ------------------------------ 6ms Apr 28 17:23:30 volumio volumio[881]: info: sendMpdCommand status took 5 milliseconds Apr 28 17:23:30 volumio volumio[881]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 28 17:23:30 volumio volumio[881]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 28 17:23:30 volumio volumio[881]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 28 17:23:30 volumio volumio[881]: info: ------------------------------ 3ms Apr 28 17:23:30 volumio volumio[881]: info: sendMpdCommand status took 3 milliseconds Apr 28 17:23:30 volumio volumio[881]: info: ------------------------------ 4ms Apr 28 17:23:30 volumio volumio[881]: info: sendMpdCommand status took 2 milliseconds Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::parseState Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 17:23:30 volumio volumio[881]: info: ControllerMpd::pushState Apr 28 17:23:30 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:23:30 volumio volumio[881]: verbose: In UPNP mode Apr 28 17:23:30 volumio volumio[881]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"249 Kbps","isStreaming":false,"title":"d5eeacd070904c0ab727aa6967d2ffbb.flac","artist":"Music Assistant","album":null,"uri":"http://10.13.8.10:8097/flow/RaTWBoNQ/uuid:548a2cb5-2925-37ea-1818-00199970b6e6/d5eeacd070904c0ab727aa6967d2ffbb.flac","trackType":"flac"} Apr 28 17:23:30 volumio volumio[881]: verbose: CURRENT POSITION 0 Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::syncState stateService play Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::syncState currentStatus stop Apr 28 17:23:30 volumio volumio[881]: info: ControllerMpd::pushState Apr 28 17:23:30 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:23:30 volumio volumio[881]: verbose: In UPNP mode Apr 28 17:23:30 volumio volumio[881]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"260 Kbps","isStreaming":false,"title":"d5eeacd070904c0ab727aa6967d2ffbb.flac","artist":"Music Assistant","album":null,"uri":"http://10.13.8.10:8097/flow/RaTWBoNQ/uuid:548a2cb5-2925-37ea-1818-00199970b6e6/d5eeacd070904c0ab727aa6967d2ffbb.flac","trackType":"flac"} Apr 28 17:23:30 volumio volumio[881]: verbose: CURRENT POSITION 0 Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::syncState stateService play Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::syncState currentStatus play Apr 28 17:23:30 volumio volumio[881]: info: Received an update from plugin. extracting info from payload Apr 28 17:23:30 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:23:30 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:23:30 volumio volumio[881]: info: ControllerMpd::pushState Apr 28 17:23:30 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:23:30 volumio volumio[881]: verbose: In UPNP mode Apr 28 17:23:30 volumio volumio[881]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"255 Kbps","isStreaming":false,"title":"d5eeacd070904c0ab727aa6967d2ffbb.flac","artist":"Music Assistant","album":null,"uri":"http://10.13.8.10:8097/flow/RaTWBoNQ/uuid:548a2cb5-2925-37ea-1818-00199970b6e6/d5eeacd070904c0ab727aa6967d2ffbb.flac","trackType":"flac"} Apr 28 17:23:30 volumio volumio[881]: verbose: CURRENT POSITION 0 Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::syncState stateService play Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::syncState currentStatus play Apr 28 17:23:30 volumio volumio[881]: info: Received an update from plugin. extracting info from payload Apr 28 17:23:30 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:23:30 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:23:30 volumio volumio[881]: info: ------------------------------ 52ms Apr 28 17:23:30 volumio volumio[881]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Apr 28 17:23:30 volumio volumio[881]: info: ------------------------------ 48ms Apr 28 17:23:30 volumio volumio[881]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 28 17:23:30 volumio volumio[881]: info: ControllerMpd::pushState Apr 28 17:23:30 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:23:30 volumio volumio[881]: verbose: In UPNP mode Apr 28 17:23:30 volumio volumio[881]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"266 Kbps","isStreaming":false,"title":"d5eeacd070904c0ab727aa6967d2ffbb.flac","artist":"Music Assistant","album":null,"uri":"http://10.13.8.10:8097/flow/RaTWBoNQ/uuid:548a2cb5-2925-37ea-1818-00199970b6e6/d5eeacd070904c0ab727aa6967d2ffbb.flac","trackType":"flac"} Apr 28 17:23:30 volumio volumio[881]: verbose: CURRENT POSITION 0 Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::syncState stateService play Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::syncState currentStatus play Apr 28 17:23:30 volumio volumio[881]: info: Received an update from plugin. extracting info from payload Apr 28 17:23:30 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:23:30 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:23:30 volumio volumio[881]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Apr 28 17:23:30 volumio volumio[881]: info: ------------------------------ 15ms Apr 28 17:23:30 volumio volumio[881]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 28 17:23:30 volumio volumio[881]: verbose: ControllerMpd::parseTrackInfo Apr 28 17:23:30 volumio volumio[881]: info: ControllerMpd::pushState Apr 28 17:23:30 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:23:30 volumio volumio[881]: verbose: In UPNP mode Apr 28 17:23:30 volumio volumio[881]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"266 Kbps","isStreaming":false,"title":"d5eeacd070904c0ab727aa6967d2ffbb.flac","artist":"Music Assistant","album":null,"uri":"http://10.13.8.10:8097/flow/RaTWBoNQ/uuid:548a2cb5-2925-37ea-1818-00199970b6e6/d5eeacd070904c0ab727aa6967d2ffbb.flac","trackType":"flac"} Apr 28 17:23:30 volumio volumio[881]: verbose: CURRENT POSITION 0 Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::syncState stateService play Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::syncState currentStatus play Apr 28 17:23:30 volumio volumio[881]: info: Received an update from plugin. extracting info from payload Apr 28 17:23:30 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:23:30 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:23:30 volumio volumio[881]: info: ControllerMpd::pushState Apr 28 17:23:30 volumio volumio[881]: info: CoreCommandRouter::servicePushState Apr 28 17:23:30 volumio volumio[881]: verbose: In UPNP mode Apr 28 17:23:30 volumio volumio[881]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"266 Kbps","isStreaming":false,"title":"d5eeacd070904c0ab727aa6967d2ffbb.flac","artist":"Music Assistant","album":null,"uri":"http://10.13.8.10:8097/flow/RaTWBoNQ/uuid:548a2cb5-2925-37ea-1818-00199970b6e6/d5eeacd070904c0ab727aa6967d2ffbb.flac","trackType":"flac"} Apr 28 17:23:30 volumio volumio[881]: verbose: CURRENT POSITION 0 Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::syncState stateService play Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::syncState currentStatus play Apr 28 17:23:30 volumio volumio[881]: info: Received an update from plugin. extracting info from payload Apr 28 17:23:30 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 28 17:23:30 volumio volumio[881]: info: CoreStateMachine::pushState Apr 28 17:23:30 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:23:30 volumio volumio[881]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Apr 28 17:23:30 volumio volumio[881]: info: ------------------------------ 18ms Apr 28 17:23:30 volumio volumio[881]: info: ------------------------------ 17ms Apr 28 17:23:31 volumio sudo[27425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 28 17:23:31 volumio sudo[27425]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:23:31 volumio sudo[27425]: pam_unix(sudo:session): session closed for user root Apr 28 17:23:31 volumio sudo[27428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 28 17:23:31 volumio sudo[27428]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:23:31 volumio sudo[27428]: pam_unix(sudo:session): session closed for user root Apr 28 17:23:31 volumio sudo[27434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 28 17:23:31 volumio sudo[27434]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:23:31 volumio sudo[27434]: pam_unix(sudo:session): session closed for user root Apr 28 17:23:31 volumio sudo[27437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 28 17:23:31 volumio sudo[27437]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 17:23:31 volumio sudo[27437]: pam_unix(sudo:session): session closed for user root Apr 28 17:23:31 volumio volumio[881]: verbose: New Socket.io Connection to 10.13.10.15 from 10.12.100.58 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 5 Apr 28 17:23:31 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 28 17:23:31 volumio volumio[881]: info: CoreCommandRouter::volumioGetVisibleSources Apr 28 17:23:31 volumio volumio[881]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 17:23:31 volumio volumio[881]: info: CoreCommandRouter::volumioGetState Apr 28 17:23:31 volumio volumio[881]: info: CorePlayQueue::getTrack 0 Apr 28 17:23:31 volumio volumio[881]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 17:23:31 volumio volumio[881]: TypeError: Cannot read property 'name' of undefined Apr 28 17:23:31 volumio volumio[881]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Apr 28 17:23:31 volumio volumio[881]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Apr 28 17:23:31 volumio volumio[881]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:58:38) Apr 28 17:23:31 volumio volumio[881]: at Socket.emit (events.js:400:28) Apr 28 17:23:31 volumio volumio[881]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Apr 28 17:23:31 volumio volumio[881]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Apr 28 17:23:31 volumio volumio[881]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 17:23:31 volumio sudo[27450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-28 17:22 Apr 28 17:23:31 volumio sudo[27450]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"