-- Logs begin at Thu 2019-02-14 12:11:58 EET, end at Thu 2025-03-13 21:33:41 EET. -- Mar 13 21:32:03 volumio volumio[973]: info: CoreCommandRouter::volumioGetState Mar 13 21:32:03 volumio volumio[973]: info: Listing playlists Mar 13 21:32:03 volumio volumio[973]: info: Listing playlists Mar 13 21:32:13 volumio volumio[973]: info: CoreCommandRouter::volumioGetState Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::servicePushState Mar 13 21:32:15 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::volumioPushState Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::servicePushState Mar 13 21:32:15 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::volumioPushState Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::servicePushState Mar 13 21:32:15 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::volumioPushState Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::servicePushState Mar 13 21:32:15 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::volumioPushState Mar 13 21:32:15 volumio volumio[973]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30 Mar 13 21:32:15 volumio volumio[973]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30 Mar 13 21:32:15 volumio volumio[973]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30 Mar 13 21:32:15 volumio volumio[973]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30 Mar 13 21:32:15 volumio shairport-sync[1258]: {"time":1741894304525,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Mar 13 21:32:15 volumio shairport-sync[1258]: Dload Upload Total Spent Left Speed Mar 13 21:32:15 volumio volumio[973]: info: Mar 13 21:32:15 volumio volumio[973]: ---------------------------- Client requests Stop Airplay Playback Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Mar 13 21:32:15 volumio volumio[973]: info: Airplay playback stop Mar 13 21:32:15 volumio volumio[973]: info: Airplay Playback Stopped, clearing state Mar 13 21:32:15 volumio volumio[973]: info: CoreStateMachine::resetVolumioState Mar 13 21:32:15 volumio volumio[973]: info: CoreStateMachine::getcurrentVolume Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::volumioRetrievevolume Mar 13 21:32:15 volumio shairport-sync[1258]: [158B blob data] Mar 13 21:32:15 volumio volumio[973]: info: VolumeController:: Volume=30 Mute =false Mar 13 21:32:15 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::volumioPushState Mar 13 21:32:15 volumio volumio[973]: info: CoreStateMachine::updateTrackBlock Mar 13 21:32:15 volumio volumio[973]: info: CorePlayQueue::getTrackBlock Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::volumioRetrievevolume Mar 13 21:32:15 volumio volumio[973]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30 Mar 13 21:32:15 volumio volumio[973]: info: VolumeController:: Volume=30 Mute =false Mar 13 21:32:15 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:32:15 volumio volumio[973]: info: CoreCommandRouter::volumioPushState Mar 13 21:32:15 volumio volumio[973]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30 Mar 13 21:32:23 volumio volumio[973]: info: CoreCommandRouter::volumioGetState Mar 13 21:32:23 volumio volumio[973]: info: Listing playlists Mar 13 21:32:23 volumio volumio[973]: info: Listing playlists Mar 13 21:32:33 volumio volumio[973]: info: CoreCommandRouter::volumioGetState Mar 13 21:32:43 volumio volumio[973]: info: CoreCommandRouter::volumioGetState Mar 13 21:32:43 volumio volumio[973]: info: Listing playlists Mar 13 21:32:53 volumio volumio[973]: info: CoreCommandRouter::volumioGetState Mar 13 21:33:03 volumio volumio[973]: info: CoreCommandRouter::volumioGetState Mar 13 21:33:03 volumio volumio[973]: info: Listing playlists Mar 13 21:33:03 volumio volumio[973]: info: Listing playlists Mar 13 21:33:13 volumio volumio[973]: info: CoreCommandRouter::volumioGetState Mar 13 21:33:23 volumio volumio[973]: info: CoreCommandRouter::volumioGetState Mar 13 21:33:23 volumio volumio[973]: info: Listing playlists Mar 13 21:33:23 volumio volumio[973]: info: Listing playlists Mar 13 21:33:24 volumio volumio[973]: info: Clearing queue after UPNP request Mar 13 21:33:24 volumio volumio[973]: verbose: UNSET VOLATILE: Service: airplay_emulation Mar 13 21:33:24 volumio volumio[973]: info: Stopping Airplay Playback and sending pause command to client via USR2 Mar 13 21:33:24 volumio sudo[22881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 1258 Mar 13 21:33:24 volumio sudo[22881]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 21:33:24 volumio sudo[22881]: pam_unix(sudo:session): session closed for user root Mar 13 21:33:24 volumio volumio[973]: info: Shairport-Sync paused with USR2 Mar 13 21:33:24 volumio volumio[973]: info: CoreStateMachine::ClearQueue Mar 13 21:33:24 volumio volumio[973]: info: CoreStateMachine::stop Mar 13 21:33:24 volumio volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 21:33:24 volumio volumio[973]: info: CorePlayQueue::clearPlayQueue Mar 13 21:33:24 volumio volumio[973]: info: CorePlayQueue::saveQueue Mar 13 21:33:24 volumio volumio[973]: info: CoreCommandRouter::volumioPushState Mar 13 21:33:24 volumio volumio[973]: info: CoreCommandRouter::volumioPushQueue Mar 13 21:33:24 volumio volumio[973]: error: Upnp client error: Error: This socket has been ended by the other party Mar 13 21:33:24 volumio volumio[973]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30 Mar 13 21:33:25 volumio volumio[973]: info: Restarting Shairport-Sync after stop Mar 13 21:33:25 volumio sudo[22884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 13 21:33:25 volumio sudo[22884]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 21:33:25 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 13 21:33:25 volumio shairport-sync[1258]: {"time":1741894335537,"response":"stopAirplayPlayback Success"} Mar 13 21:33:25 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 13 21:33:25 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 13 21:33:25 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 13 21:33:25 volumio sudo[22884]: pam_unix(sudo:session): session closed for user root Mar 13 21:33:25 volumio volumio[973]: info: Shairport-Sync retarted Mar 13 21:33:26 volumio volumio[973]: info: Starting UPNP Playback Mar 13 21:33:26 volumio volumio[973]: info: Preparing playback through UPNP Mar 13 21:33:26 volumio volumio[973]: info: CoreCommandRouter::volumioGetState Mar 13 21:33:26 volumio volumio[973]: info: CorePlayQueue::getTrack 0 Mar 13 21:33:26 volumio volumio[973]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 6ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 5ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 4ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 3ms Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 3ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 3ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 2ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 2ms Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 2ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 1ms Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 1ms Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 2ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 3ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 2ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 1ms Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 3ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 2ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 1ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 1ms Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 1ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 1ms Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 2ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 1ms Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces state update: player Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::getState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand status Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces state update: player Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::getState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand status Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces state update: player Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::getState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand status Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces state update: player Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::getState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand status Mar 13 21:33:27 volumio volumio[973]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Mar 13 21:33:27 volumio volumio[973]: info: FusionDsp - ---- read samplerate from file: 48000 Mar 13 21:33:27 volumio volumio[973]: info: camilladsp stopping service pid 22626... Mar 13 21:33:27 volumio volumio[973]: info: camilladsp service terminated, instance 1 Mar 13 21:33:27 volumio volumio[973]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 13 21:33:27 volumio volumio[973]: info: camilladsp service started and running in background, instance 1 Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces state update: player Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand status took 54 milliseconds Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::getState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand status Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand status took 53 milliseconds Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand status took 52 milliseconds Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand status took 51 milliseconds Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces state update: player Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::getState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand status Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces state update: player Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::getState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand status Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces system playlist update Mar 13 21:33:27 volumio volumio[973]: info: Ignoring MPD Status Update Mar 13 21:33:27 volumio volumio[973]: info: Mar 13 21:33:27 volumio volumio[973]: ---------------------------- MPD announces state update: player Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::getState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand status Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 12ms Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand status took 10 milliseconds Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 5ms Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand status took 5 milliseconds Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 5ms Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand status took 4 milliseconds Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 4ms Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand status took 3 milliseconds Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseTrackInfo Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseTrackInfo Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseState Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::pushState Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::servicePushState Mar 13 21:33:27 volumio volumio[973]: verbose: In UPNP mode Mar 13 21:33:27 volumio volumio[973]: 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":null,"isStreaming":false,"title":"e3d916f065924d0dadd875a112a91abb.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.0.100:8097/flow/uuid:548a2cb5-2925-37ea-1818-e45f016e1737/e3d916f065924d0dadd875a112a91abb.flac","trackType":"flac"} Mar 13 21:33:27 volumio volumio[973]: verbose: CURRENT POSITION 0 Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState stateService play Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState currentStatus stop Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::pushState Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::servicePushState Mar 13 21:33:27 volumio volumio[973]: verbose: In UPNP mode Mar 13 21:33:27 volumio volumio[973]: 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":"721 Kbps","isStreaming":false,"title":"e3d916f065924d0dadd875a112a91abb.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.0.100:8097/flow/uuid:548a2cb5-2925-37ea-1818-e45f016e1737/e3d916f065924d0dadd875a112a91abb.flac","trackType":"flac"} Mar 13 21:33:27 volumio volumio[973]: verbose: CURRENT POSITION 0 Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState stateService play Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState currentStatus play Mar 13 21:33:27 volumio volumio[973]: info: Received an update from plugin. extracting info from payload Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:33:27 volumio volumio[973]: info: CorePlayQueue::getTrack 0 Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::pushState Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::servicePushState Mar 13 21:33:27 volumio volumio[973]: verbose: In UPNP mode Mar 13 21:33:27 volumio volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":840,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"721 Kbps","isStreaming":false,"title":"e3d916f065924d0dadd875a112a91abb.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.0.100:8097/flow/uuid:548a2cb5-2925-37ea-1818-e45f016e1737/e3d916f065924d0dadd875a112a91abb.flac","trackType":"flac"} Mar 13 21:33:27 volumio volumio[973]: verbose: CURRENT POSITION 0 Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState stateService play Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState currentStatus play Mar 13 21:33:27 volumio volumio[973]: info: Received an update from plugin. extracting info from payload Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:33:27 volumio volumio[973]: info: CorePlayQueue::getTrack 0 Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::pushState Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::servicePushState Mar 13 21:33:27 volumio volumio[973]: verbose: In UPNP mode Mar 13 21:33:27 volumio volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":840,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"721 Kbps","isStreaming":false,"title":"e3d916f065924d0dadd875a112a91abb.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.0.100:8097/flow/uuid:548a2cb5-2925-37ea-1818-e45f016e1737/e3d916f065924d0dadd875a112a91abb.flac","trackType":"flac"} Mar 13 21:33:27 volumio volumio[973]: verbose: CURRENT POSITION 0 Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState stateService play Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState currentStatus play Mar 13 21:33:27 volumio volumio[973]: info: Received an update from plugin. extracting info from payload Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:33:27 volumio volumio[973]: info: CorePlayQueue::getTrack 0 Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 80ms Mar 13 21:33:27 volumio volumio[973]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Mar 13 21:33:27 volumio volumio[973]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Mar 13 21:33:27 volumio volumio[973]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 79ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 78ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 77ms Mar 13 21:33:27 volumio volumio[973]: info: camilladsp spawned new process with pid 22901, instance 1, run: true Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand playlistinfo took 34 milliseconds Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand playlistinfo took 28 milliseconds Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand playlistinfo took 28 milliseconds Mar 13 21:33:27 volumio volumio[973]: info: sendMpdCommand playlistinfo took 27 milliseconds Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseTrackInfo Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseTrackInfo Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseTrackInfo Mar 13 21:33:27 volumio volumio[973]: verbose: ControllerMpd::parseTrackInfo Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::pushState Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::servicePushState Mar 13 21:33:27 volumio volumio[973]: verbose: In UPNP mode Mar 13 21:33:27 volumio volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":840,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"721 Kbps","isStreaming":false,"title":"e3d916f065924d0dadd875a112a91abb.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.0.100:8097/flow/uuid:548a2cb5-2925-37ea-1818-e45f016e1737/e3d916f065924d0dadd875a112a91abb.flac","trackType":"flac"} Mar 13 21:33:27 volumio volumio[973]: verbose: CURRENT POSITION 0 Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState stateService play Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState currentStatus play Mar 13 21:33:27 volumio volumio[973]: info: Received an update from plugin. extracting info from payload Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:33:27 volumio volumio[973]: info: CorePlayQueue::getTrack 0 Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::pushState Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::servicePushState Mar 13 21:33:27 volumio volumio[973]: verbose: In UPNP mode Mar 13 21:33:27 volumio volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":840,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"721 Kbps","isStreaming":false,"title":"e3d916f065924d0dadd875a112a91abb.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.0.100:8097/flow/uuid:548a2cb5-2925-37ea-1818-e45f016e1737/e3d916f065924d0dadd875a112a91abb.flac","trackType":"flac"} Mar 13 21:33:27 volumio volumio[973]: verbose: CURRENT POSITION 0 Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState stateService play Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState currentStatus play Mar 13 21:33:27 volumio volumio[973]: info: Received an update from plugin. extracting info from payload Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:33:27 volumio volumio[973]: info: CorePlayQueue::getTrack 0 Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::pushState Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::servicePushState Mar 13 21:33:27 volumio volumio[973]: verbose: In UPNP mode Mar 13 21:33:27 volumio volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":840,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"721 Kbps","isStreaming":false,"title":"e3d916f065924d0dadd875a112a91abb.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.0.100:8097/flow/uuid:548a2cb5-2925-37ea-1818-e45f016e1737/e3d916f065924d0dadd875a112a91abb.flac","trackType":"flac"} Mar 13 21:33:27 volumio volumio[973]: verbose: CURRENT POSITION 0 Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState stateService play Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState currentStatus play Mar 13 21:33:27 volumio volumio[973]: info: Received an update from plugin. extracting info from payload Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:33:27 volumio volumio[973]: info: CorePlayQueue::getTrack 0 Mar 13 21:33:27 volumio volumio[973]: info: ControllerMpd::pushState Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::servicePushState Mar 13 21:33:27 volumio volumio[973]: verbose: In UPNP mode Mar 13 21:33:27 volumio volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":840,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"721 Kbps","isStreaming":false,"title":"e3d916f065924d0dadd875a112a91abb.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.0.100:8097/flow/uuid:548a2cb5-2925-37ea-1818-e45f016e1737/e3d916f065924d0dadd875a112a91abb.flac","trackType":"flac"} Mar 13 21:33:27 volumio volumio[973]: verbose: CURRENT POSITION 0 Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState stateService play Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::syncState currentStatus play Mar 13 21:33:27 volumio volumio[973]: info: Received an update from plugin. extracting info from payload Mar 13 21:33:27 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 13 21:33:27 volumio volumio[973]: info: CoreStateMachine::pushState Mar 13 21:33:27 volumio volumio[973]: info: CorePlayQueue::getTrack 0 Mar 13 21:33:27 volumio volumio[973]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 55ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 48ms Mar 13 21:33:27 volumio volumio[973]: info: ------------------------------ 47ms Mar 13 21:33:33 volumio volumio[973]: info: CoreCommandRouter::volumioGetState Mar 13 21:33:33 volumio volumio[973]: info: CorePlayQueue::getTrack 0 Mar 13 21:33:33 volumio volumio[973]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Mar 13 21:33:33 volumio volumio[973]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Mar 13 21:33:33 volumio volumio[973]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Mar 13 21:33:33 volumio volumio[973]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Mar 13 21:33:33 volumio volumio[973]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Mar 13 21:33:33 volumio volumio[973]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Mar 13 21:33:33 volumio volumio[973]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Mar 13 21:33:33 volumio volumio[973]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Mar 13 21:33:33 volumio volumio[973]: at /volumio/node_modules/express/lib/router/index.js:281:22 Mar 13 21:33:33 volumio volumio[973]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Mar 13 21:33:33 volumio volumio[973]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Mar 13 21:33:33 volumio volumio[973]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Mar 13 21:33:33 volumio volumio[973]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Mar 13 21:33:33 volumio volumio[973]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Mar 13 21:33:33 volumio volumio[973]: at /volumio/node_modules/express/lib/router/index.js:284:7 Mar 13 21:33:33 volumio volumio[973]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Mar 13 21:33:33 volumio volumio[973]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Mar 13 21:33:40 volumio sudo[22974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 13 21:33:40 volumio sudo[22974]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 21:33:40 volumio sudo[22974]: pam_unix(sudo:session): session closed for user root Mar 13 21:33:40 volumio sudo[22977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 13 21:33:40 volumio sudo[22977]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 21:33:40 volumio sudo[22977]: pam_unix(sudo:session): session closed for user root Mar 13 21:33:41 volumio volumio[973]: verbose: New Socket.io Connection to 192.168.0.250 from 192.168.7.89 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.3.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 6 Mar 13 21:33:41 volumio volumio[973]: info: CoreCommandRouter::volumioGetState Mar 13 21:33:41 volumio volumio[973]: info: CorePlayQueue::getTrack 0 Mar 13 21:33:41 volumio volumio[973]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 13 21:33:41 volumio volumio[973]: TypeError: Cannot read property 'name' of undefined Mar 13 21:33:41 volumio volumio[973]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Mar 13 21:33:41 volumio volumio[973]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Mar 13 21:33:41 volumio volumio[973]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:58:38) Mar 13 21:33:41 volumio volumio[973]: at Socket.emit (events.js:315:20) Mar 13 21:33:41 volumio volumio[973]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Mar 13 21:33:41 volumio volumio[973]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Mar 13 21:33:41 volumio volumio[973]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 13 21:33:41 volumio sudo[22988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-13 21:32 Mar 13 21:33:41 volumio sudo[22988]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"