-- Logs begin at Sat 2024-03-09 19:39:14 UTC, end at Fri 2024-10-04 21:18:36 UTC. -- Oct 04 21:17:44 volumio volumio[841]: info: Clearing queue after UPNP request Oct 04 21:17:44 volumio volumio[841]: verbose: UNSET VOLATILE: Service: airplay_emulation Oct 04 21:17:44 volumio volumio[841]: info: Stopping Airplay Playback and sending pause command to client via USR2 Oct 04 21:17:44 volumio sudo[31752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 1023 Oct 04 21:17:44 volumio sudo[31752]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 21:17:44 volumio sudo[31752]: pam_unix(sudo:session): session closed for user root Oct 04 21:17:44 volumio volumio[841]: info: Shairport-Sync paused with USR2 Oct 04 21:17:44 volumio volumio[841]: info: CoreStateMachine::ClearQueue Oct 04 21:17:44 volumio volumio[841]: info: CoreStateMachine::stop Oct 04 21:17:44 volumio volumio[841]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 04 21:17:44 volumio volumio[841]: info: CorePlayQueue::clearPlayQueue Oct 04 21:17:44 volumio volumio[841]: info: CorePlayQueue::saveQueue Oct 04 21:17:44 volumio volumio[841]: info: CoreCommandRouter::volumioPushState Oct 04 21:17:44 volumio volumio[841]: info: CoreCommandRouter::volumioPushQueue Oct 04 21:17:44 volumio volumio[841]: error: Upnp client error: Error: This socket has been ended by the other party Oct 04 21:17:45 volumio volumio[841]: info: Restarting Shairport-Sync after stop Oct 04 21:17:45 volumio sudo[31755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 04 21:17:45 volumio sudo[31755]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 21:17:45 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 04 21:17:45 volumio shairport-sync[1023]: {"time":1728076582396,"response":"stopAirplayPlayback Success"} Oct 04 21:17:45 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 04 21:17:45 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 04 21:17:45 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 04 21:17:45 volumio sudo[31755]: pam_unix(sudo:session): session closed for user root Oct 04 21:17:45 volumio volumio[841]: info: Shairport-Sync retarted Oct 04 21:17:46 volumio volumio[841]: info: Starting UPNP Playback Oct 04 21:17:46 volumio volumio[841]: info: Preparing playback through UPNP Oct 04 21:17:46 volumio volumio[841]: info: CoreCommandRouter::volumioGetState Oct 04 21:17:46 volumio volumio[841]: info: CorePlayQueue::getTrack 0 Oct 04 21:17:46 volumio volumio[841]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 8ms Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 5ms Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 4ms Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 3ms Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 3ms Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 2ms Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 3ms Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 2ms Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 1ms Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 5ms Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 4ms Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 3ms Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 4ms Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 2ms Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 3ms Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: Oct 04 21:17:46 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:17:46 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 4ms Oct 04 21:17:46 volumio volumio[841]: info: ------------------------------ 3ms Oct 04 21:17:54 volumio volumio[976]: 39 Oct 04 21:17:54 volumio volumio[976]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 04 21:17:54 volumio volumio[976]: Dload Upload Total Spent Left Speed Oct 04 21:17:54 volumio volumio[841]: info: Oct 04 21:17:54 volumio volumio[841]: ---------------------------- Client requests Volume 39 Oct 04 21:17:54 volumio volumio[841]: info: VolumeController::SetAlsaVolume39 Oct 04 21:17:54 volumio volumio[841]: info: CoreStateMachine::pushState Oct 04 21:17:54 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 04 21:17:54 volumio volumio[841]: info: CoreCommandRouter::volumioPushState Oct 04 21:17:54 volumio volumio[976]: [158B blob data] Oct 04 21:17:54 volumio volumio[976]: {"time":1728076674210,"response":"volume Success"}39 Oct 04 21:18:06 volumio volumio[976]: 48 Oct 04 21:18:06 volumio volumio[976]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 04 21:18:06 volumio volumio[976]: Dload Upload Total Spent Left Speed Oct 04 21:18:06 volumio volumio[841]: info: Oct 04 21:18:06 volumio volumio[841]: ---------------------------- Client requests Volume 48 Oct 04 21:18:06 volumio volumio[841]: info: VolumeController::SetAlsaVolume48 Oct 04 21:18:06 volumio volumio[841]: info: CoreStateMachine::pushState Oct 04 21:18:06 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 04 21:18:06 volumio volumio[841]: info: CoreCommandRouter::volumioPushState Oct 04 21:18:06 volumio volumio[976]: [158B blob data] Oct 04 21:18:06 volumio volumio[976]: {"time":1728076686790,"response":"volume Success"}48 Oct 04 21:18:11 volumio volumio[976]: 31 Oct 04 21:18:11 volumio volumio[976]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 04 21:18:11 volumio volumio[976]: Dload Upload Total Spent Left Speed Oct 04 21:18:11 volumio volumio[841]: info: Oct 04 21:18:11 volumio volumio[841]: ---------------------------- Client requests Volume 31 Oct 04 21:18:11 volumio volumio[841]: info: VolumeController::SetAlsaVolume31 Oct 04 21:18:11 volumio volumio[841]: info: CoreStateMachine::pushState Oct 04 21:18:11 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 04 21:18:11 volumio volumio[841]: info: CoreCommandRouter::volumioPushState Oct 04 21:18:11 volumio volumio[976]: [158B blob data] Oct 04 21:18:11 volumio volumio[976]: {"time":1728076691365,"response":"volume Success"}31 Oct 04 21:18:15 volumio volumio[841]: info: Oct 04 21:18:15 volumio volumio[841]: ---------------------------- MPD announces state update: player Oct 04 21:18:15 volumio volumio[841]: info: ControllerMpd::getState Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 04 21:18:15 volumio volumio[841]: info: Oct 04 21:18:15 volumio volumio[841]: ---------------------------- MPD announces state update: player Oct 04 21:18:15 volumio volumio[841]: info: ControllerMpd::getState Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 04 21:18:15 volumio volumio[841]: info: Oct 04 21:18:15 volumio volumio[841]: ---------------------------- MPD announces state update: player Oct 04 21:18:15 volumio volumio[841]: info: ControllerMpd::getState Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 04 21:18:15 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Oct 04 21:18:15 volumio volumio[841]: info: sendMpdCommand status took 17 milliseconds Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::parseState Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 21:18:15 volumio volumio[841]: info: Oct 04 21:18:15 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:18:15 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:18:15 volumio volumio[841]: info: Oct 04 21:18:15 volumio volumio[841]: ---------------------------- MPD announces state update: player Oct 04 21:18:15 volumio volumio[841]: info: ControllerMpd::getState Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 04 21:18:15 volumio volumio[841]: info: sendMpdCommand status took 18 milliseconds Oct 04 21:18:15 volumio volumio[841]: info: sendMpdCommand status took 17 milliseconds Oct 04 21:18:15 volumio volumio[841]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::parseState Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::parseState Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 04 21:18:15 volumio volumio[841]: info: ControllerMpd::pushState Oct 04 21:18:15 volumio volumio[841]: info: CoreCommandRouter::servicePushState Oct 04 21:18:15 volumio volumio[841]: verbose: In UPNP mode Oct 04 21:18:15 volumio volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"swyh.flac","artist":"swyh-rs","album":null,"uri":"http://192.168.0.108:5901/stream/swyh.flac","trackType":"flac"} Oct 04 21:18:15 volumio volumio[841]: verbose: CURRENT POSITION 0 Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::syncState stateService play Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::syncState currentStatus stop Oct 04 21:18:15 volumio volumio[841]: info: ------------------------------ 30ms Oct 04 21:18:15 volumio volumio[841]: info: Oct 04 21:18:15 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:18:15 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:18:15 volumio volumio[841]: info: Oct 04 21:18:15 volumio volumio[841]: ---------------------------- MPD announces state update: player Oct 04 21:18:15 volumio volumio[841]: info: ControllerMpd::getState Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 04 21:18:15 volumio volumio[841]: info: Oct 04 21:18:15 volumio volumio[841]: ---------------------------- MPD announces system playlist update Oct 04 21:18:15 volumio volumio[841]: info: Ignoring MPD Status Update Oct 04 21:18:15 volumio volumio[841]: info: Oct 04 21:18:15 volumio volumio[841]: ---------------------------- MPD announces state update: player Oct 04 21:18:15 volumio volumio[841]: info: ControllerMpd::getState Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 04 21:18:15 volumio volumio[841]: info: ------------------------------ 15ms Oct 04 21:18:15 volumio volumio[841]: info: sendMpdCommand status took 13 milliseconds Oct 04 21:18:15 volumio volumio[841]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 04 21:18:15 volumio volumio[841]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 04 21:18:15 volumio volumio[841]: info: ------------------------------ 7ms Oct 04 21:18:15 volumio volumio[841]: info: sendMpdCommand status took 6 milliseconds Oct 04 21:18:15 volumio volumio[841]: info: ------------------------------ 6ms Oct 04 21:18:15 volumio volumio[841]: info: sendMpdCommand status took 4 milliseconds Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::parseState Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::parseState Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::parseState Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 21:18:15 volumio volumio[841]: info: ControllerMpd::pushState Oct 04 21:18:15 volumio volumio[841]: info: CoreCommandRouter::servicePushState Oct 04 21:18:15 volumio volumio[841]: verbose: In UPNP mode Oct 04 21:18:15 volumio volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4 Kbps","isStreaming":false,"title":"swyh.flac","artist":"swyh-rs","album":null,"uri":"http://192.168.0.108:5901/stream/swyh.flac","trackType":"flac"} Oct 04 21:18:15 volumio volumio[841]: verbose: CURRENT POSITION 0 Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::syncState stateService play Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 04 21:18:15 volumio volumio[841]: info: Received an update from plugin. extracting info from payload Oct 04 21:18:15 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::pushState Oct 04 21:18:15 volumio volumio[841]: info: CorePlayQueue::getTrack 0 Oct 04 21:18:15 volumio volumio[841]: info: ControllerMpd::pushState Oct 04 21:18:15 volumio volumio[841]: info: CoreCommandRouter::servicePushState Oct 04 21:18:15 volumio volumio[841]: verbose: In UPNP mode Oct 04 21:18:15 volumio volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":137,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4 Kbps","isStreaming":false,"title":"swyh.flac","artist":"swyh-rs","album":null,"uri":"http://192.168.0.108:5901/stream/swyh.flac","trackType":"flac"} Oct 04 21:18:15 volumio volumio[841]: verbose: CURRENT POSITION 0 Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::syncState stateService play Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 04 21:18:15 volumio volumio[841]: info: Received an update from plugin. extracting info from payload Oct 04 21:18:15 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::pushState Oct 04 21:18:15 volumio volumio[841]: info: CorePlayQueue::getTrack 0 Oct 04 21:18:15 volumio volumio[841]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Oct 04 21:18:15 volumio volumio[841]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Oct 04 21:18:15 volumio volumio[841]: info: ------------------------------ 45ms Oct 04 21:18:15 volumio volumio[841]: info: ------------------------------ 43ms Oct 04 21:18:15 volumio volumio[841]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 04 21:18:15 volumio volumio[841]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 04 21:18:15 volumio volumio[841]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 04 21:18:15 volumio volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 04 21:18:15 volumio volumio[841]: info: ControllerMpd::pushState Oct 04 21:18:15 volumio volumio[841]: info: CoreCommandRouter::servicePushState Oct 04 21:18:15 volumio volumio[841]: verbose: In UPNP mode Oct 04 21:18:15 volumio volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4 Kbps","isStreaming":false,"title":"swyh.flac","artist":"swyh-rs","album":null,"uri":"http://192.168.0.108:5901/stream/swyh.flac","trackType":"flac"} Oct 04 21:18:15 volumio volumio[841]: verbose: CURRENT POSITION 0 Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::syncState stateService play Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 04 21:18:15 volumio volumio[841]: info: Received an update from plugin. extracting info from payload Oct 04 21:18:15 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::pushState Oct 04 21:18:15 volumio volumio[841]: info: CorePlayQueue::getTrack 0 Oct 04 21:18:15 volumio volumio[841]: info: ControllerMpd::pushState Oct 04 21:18:15 volumio volumio[841]: info: CoreCommandRouter::servicePushState Oct 04 21:18:15 volumio volumio[841]: verbose: In UPNP mode Oct 04 21:18:15 volumio volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4 Kbps","isStreaming":false,"title":"swyh.flac","artist":"swyh-rs","album":null,"uri":"http://192.168.0.108:5901/stream/swyh.flac","trackType":"flac"} Oct 04 21:18:15 volumio volumio[841]: verbose: CURRENT POSITION 0 Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::syncState stateService play Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 04 21:18:15 volumio volumio[841]: info: Received an update from plugin. extracting info from payload Oct 04 21:18:15 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::pushState Oct 04 21:18:15 volumio volumio[841]: info: CorePlayQueue::getTrack 0 Oct 04 21:18:15 volumio volumio[841]: info: ControllerMpd::pushState Oct 04 21:18:15 volumio volumio[841]: info: CoreCommandRouter::servicePushState Oct 04 21:18:15 volumio volumio[841]: verbose: In UPNP mode Oct 04 21:18:15 volumio volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4 Kbps","isStreaming":false,"title":"swyh.flac","artist":"swyh-rs","album":null,"uri":"http://192.168.0.108:5901/stream/swyh.flac","trackType":"flac"} Oct 04 21:18:15 volumio volumio[841]: verbose: CURRENT POSITION 0 Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::syncState stateService play Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 04 21:18:15 volumio volumio[841]: info: Received an update from plugin. extracting info from payload Oct 04 21:18:15 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 04 21:18:15 volumio volumio[841]: info: CoreStateMachine::pushState Oct 04 21:18:15 volumio volumio[841]: info: CorePlayQueue::getTrack 0 Oct 04 21:18:15 volumio volumio[841]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Oct 04 21:18:15 volumio volumio[841]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Oct 04 21:18:15 volumio volumio[841]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Oct 04 21:18:15 volumio volumio[841]: info: ------------------------------ 36ms Oct 04 21:18:15 volumio volumio[841]: info: ------------------------------ 27ms Oct 04 21:18:15 volumio volumio[841]: info: ------------------------------ 25ms Oct 04 21:18:36 volumio volumio[841]: info: Airplay started streaming, receiving metadatas Oct 04 21:18:36 volumio volumio[841]: info: CorePlayQueue::getTrack 0 Oct 04 21:18:36 volumio volumio[841]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 04 21:18:36 volumio volumio[841]: TypeError: Cannot read property 'name' of undefined Oct 04 21:18:36 volumio volumio[841]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Oct 04 21:18:36 volumio volumio[841]: at AirPlayInterface.prepareAirplayPlayback (/volumio/app/plugins/music_service/airplay_emulation/index.js:538:47) Oct 04 21:18:36 volumio volumio[841]: at ShairportSyncReaderUDP. (/volumio/app/plugins/music_service/airplay_emulation/index.js:257:12) Oct 04 21:18:36 volumio volumio[841]: at ShairportSyncReaderUDP.emit (events.js:327:22) Oct 04 21:18:36 volumio volumio[841]: at ShairportSyncReaderUDP.useData (/volumio/app/plugins/music_service/airplay_emulation/shairport-sync-reader/shairport-sync-reader-base.js:86:16) Oct 04 21:18:36 volumio volumio[841]: at Socket. (/volumio/app/plugins/music_service/airplay_emulation/shairport-sync-reader/shairport-sync-reader-udp.js:21:12) Oct 04 21:18:36 volumio volumio[841]: at Socket.emit (events.js:315:20) Oct 04 21:18:36 volumio volumio[841]: at UDP.onMessage [as onmessage] (dgram.js:919:8) Oct 04 21:18:36 volumio volumio[841]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 04 21:18:36 volumio shairport-sync[31757]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 04 21:18:36 volumio shairport-sync[31757]: Dload Upload Total Spent Left Speed Oct 04 21:18:36 volumio sudo[31952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-04 21:17 Oct 04 21:18:36 volumio sudo[31952]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"