-- Logs begin at Sun 2024-11-24 12:48:52 CET, end at Tue 2024-11-26 08:44:08 CET. -- Nov 26 08:43:54 r-i-v-o volumiologrotate[2828]: ls: cannot access '/var/log/samba/log.wb-R': No such file or directory Nov 26 08:43:54 r-i-v-o volumiologrotate[2828]: ls: cannot access 'I': No such file or directory Nov 26 08:43:54 r-i-v-o volumiologrotate[2828]: ls: cannot access 'V': No such file or directory Nov 26 08:43:54 r-i-v-o volumiologrotate[2828]: ls: cannot access 'O': No such file or directory Nov 26 08:44:01 r-i-v-o volumio[3109]: info: Clearing queue after UPNP request Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::ClearQueue Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::stop Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::updateTrackBlock Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrackBlock Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::stPlaybackTimer Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::serviceStop Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::serviceStop Nov 26 08:44:02 r-i-v-o volumio[3109]: info: ControllerMpd::stop Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::clearPlayQueue Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::saveQueue Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushQueue Nov 26 08:44:02 r-i-v-o volumio[3109]: error: Upnp client error: Error: This socket has been ended by the other party Nov 26 08:44:02 r-i-v-o volumio[3109]: info: Nov 26 08:44:02 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: player Nov 26 08:44:02 r-i-v-o volumio[3109]: info: sendMpdCommand stop took 141 milliseconds Nov 26 08:44:02 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/19845_dae52b0c-f497-4dd6-b450-209f1fd12ce2.jpg","uri":"https://stream.radioparadise.com/world-etc-flac","name":"La cumbia me está llamando","title":"La cumbia me está llamando","artist":"Nubya Garcia feat. La Perla","album":"SOURCE","streaming":true,"disableUiControls":true,"duration":256,"seek":14932,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService stop Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus stop Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: No code Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: sendMpdCommand status took 19 milliseconds Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:02 r-i-v-o volumio[3109]: info: Nov 26 08:44:02 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: player Nov 26 08:44:02 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:02 r-i-v-o volumio[3109]: info: Nov 26 08:44:02 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: player Nov 26 08:44:02 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:02 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 26 08:44:02 r-i-v-o volumio[3109]: info: sendMpdCommand status took 7 milliseconds Nov 26 08:44:02 r-i-v-o volumio[3109]: info: sendMpdCommand status took 6 milliseconds Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseTrackInfo Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:02 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService stop Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus stop Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: No code Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: ------------------------------ 43ms Nov 26 08:44:02 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 13 milliseconds Nov 26 08:44:02 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 13 milliseconds Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseTrackInfo Nov 26 08:44:02 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService stop Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus stop Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: No code Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:02 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService stop Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus stop Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: No code Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:02 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:02 r-i-v-o volumio[3109]: info: ------------------------------ 45ms Nov 26 08:44:02 r-i-v-o volumio[3109]: info: ------------------------------ 44ms Nov 26 08:44:03 r-i-v-o volumio[3109]: info: Nov 26 08:44:03 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: options Nov 26 08:44:03 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: options Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: options Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Starting UPNP Playback Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Preparing playback through UPNP Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioGetState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 26 08:44:04 r-i-v-o volumio[3109]: info: sendMpdCommand status took 8 milliseconds Nov 26 08:44:04 r-i-v-o volumio[3109]: info: sendMpdCommand status took 6 milliseconds Nov 26 08:44:04 r-i-v-o volumio[3109]: info: sendMpdCommand status took 5 milliseconds Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:04 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 08:44:04 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseTrackInfo Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseTrackInfo Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService stop Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus stop Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: No code Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService stop Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus stop Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: No code Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:04 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService stop Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus stop Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: No code Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioPushState Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 49ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 43ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 43ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Signalling Playback active due to playback status change Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Signalling Playback active due to playback status change Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Signalling Playback active due to playback status change Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Signalling Playback active due to playback status change Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Signalling Playback active due to playback status change Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Signalling Playback active due to playback status change Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Signalling Playback active due to playback status change Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Signalling Playback active due to playback status change Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Signalling Playback active due to playback status change Nov 26 08:44:04 r-i-v-o volumio[3109]: info: MCU Signalled Playback Active Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 4ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 3ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 2ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 10ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 4ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 3ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 5ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 4ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 3ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 2ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 3ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 2ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 4ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 3ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 2ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Nov 26 08:44:04 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 4ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 4ms Nov 26 08:44:04 r-i-v-o volumio[3109]: info: ------------------------------ 3ms Nov 26 08:44:06 r-i-v-o kernel: aml_spdif_open Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Nov 26 08:44:06 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: player Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Nov 26 08:44:06 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: player Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:06 r-i-v-o kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Nov 26 08:44:06 r-i-v-o kernel: set normal 512 fs /4 fs Nov 26 08:44:06 r-i-v-o kernel: set spdifout clk:22579200, mpll:90316800 Nov 26 08:44:06 r-i-v-o kernel: get spdifout clk:22579187, mpll:90316746 Nov 26 08:44:06 r-i-v-o kernel: aml_dai_set_spdif_fmt , fmt 0x4000 Nov 26 08:44:06 r-i-v-o kernel: set normal 512 fs /4 fs Nov 26 08:44:06 r-i-v-o kernel: set spdifout clk:22579200, mpll:90316800 Nov 26 08:44:06 r-i-v-o kernel: get spdifout clk:22579187, mpll:90316746 Nov 26 08:44:06 r-i-v-o kernel: spdif_info: rate: 176400, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0xc00, ch1_r:0xc00 Nov 26 08:44:06 r-i-v-o kernel: aml_spdif_fifo_ctrl, bit depth:24, frddr type:4, toddr:type:4 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Nov 26 08:44:06 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: player Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Nov 26 08:44:06 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: player Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand status took 9 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand status took 8 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand status took 7 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand status took 3 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseTrackInfo Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseTrackInfo Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: In UPNP mode Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus stop Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: In UPNP mode Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Received an update from plugin. extracting info from payload Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: In UPNP mode Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Received an update from plugin. extracting info from payload Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ------------------------------ 23ms Nov 26 08:44:06 r-i-v-o volumio[3109]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ------------------------------ 22ms Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Nov 26 08:44:06 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: player Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Nov 26 08:44:06 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: player Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand status took 3 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand status took 1 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseTrackInfo Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: In UPNP mode Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Received an update from plugin. extracting info from payload Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ------------------------------ 23ms Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseTrackInfo Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseTrackInfo Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: In UPNP mode Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Received an update from plugin. extracting info from payload Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: In UPNP mode Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Received an update from plugin. extracting info from payload Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Nov 26 08:44:06 r-i-v-o volumio[3109]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ------------------------------ 14ms Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ------------------------------ 14ms Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Nov 26 08:44:06 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Nov 26 08:44:06 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: player Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ------------------------------ 3ms Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand status took 3 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Nov 26 08:44:06 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Nov 26 08:44:06 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: player Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Nov 26 08:44:06 r-i-v-o volumio[3109]: ---------------------------- MPD announces system playlist update Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Ignoring MPD Status Update Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Nov 26 08:44:06 r-i-v-o volumio[3109]: ---------------------------- MPD announces state update: player Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::getState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand status Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ------------------------------ 6ms Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand status took 5 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ------------------------------ 3ms Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseTrackInfo Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:06 r-i-v-o kernel: asoc-aml-card auge_sound: S/PDIF Playback enable Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: In UPNP mode Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Received an update from plugin. extracting info from payload Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ------------------------------ 14ms Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand status took 7 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseTrackInfo Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: In UPNP mode Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Received an update from plugin. extracting info from payload Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ------------------------------ 15ms Nov 26 08:44:06 r-i-v-o volumio[3109]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: ControllerMpd::parseTrackInfo Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ControllerMpd::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::servicePushState Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: In UPNP mode Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: STATE SERVICE {"status":"play","position":1,"seek":22,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flac","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"https://stream.radioparadise.com/world-etc-flac","trackType":""} Nov 26 08:44:06 r-i-v-o volumio[3109]: verbose: CURRENT POSITION 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState stateService play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::syncState currentStatus play Nov 26 08:44:06 r-i-v-o volumio[3109]: info: Received an update from plugin. extracting info from payload Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CoreStateMachine::pushState Nov 26 08:44:06 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:06 r-i-v-o volumio[3109]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Nov 26 08:44:06 r-i-v-o volumio[3109]: info: ------------------------------ 16ms Nov 26 08:44:07 r-i-v-o volumio[3109]: info: Starting UPNP Playback Nov 26 08:44:07 r-i-v-o volumio[3109]: info: Preparing playback through UPNP Nov 26 08:44:07 r-i-v-o volumio[3109]: info: Consume mode Nov 26 08:44:07 r-i-v-o volumio[3109]: info: CoreCommandRouter::volumioGetState Nov 26 08:44:07 r-i-v-o volumio[3109]: info: CorePlayQueue::getTrack 0 Nov 26 08:44:07 r-i-v-o volumio[3109]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 08:44:07 r-i-v-o volumio[3109]: TypeError: Cannot read property 'name' of undefined Nov 26 08:44:07 r-i-v-o volumio[3109]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Nov 26 08:44:07 r-i-v-o volumio[3109]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Nov 26 08:44:07 r-i-v-o volumio[3109]: at UpnpInterface.prepareUpnpPlayback (/volumio/app/plugins/audio_interface/upnp/index.js:257:34) Nov 26 08:44:07 r-i-v-o volumio[3109]: at Socket. (/volumio/app/plugins/audio_interface/upnp/index.js:44:14) Nov 26 08:44:07 r-i-v-o volumio[3109]: at Socket.emit (events.js:400:28) Nov 26 08:44:07 r-i-v-o volumio[3109]: at addChunk (internal/streams/readable.js:293:12) Nov 26 08:44:07 r-i-v-o volumio[3109]: at readableAddChunk (internal/streams/readable.js:263:11) Nov 26 08:44:07 r-i-v-o volumio[3109]: at Socket.Readable.push (internal/streams/readable.js:206:10) Nov 26 08:44:07 r-i-v-o volumio[3109]: at TCP.onStreamRead (internal/stream_base_commons.js:188:23) Nov 26 08:44:07 r-i-v-o volumio[3109]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 08:44:08 r-i-v-o sudo[17700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 08:43 Nov 26 08:44:08 r-i-v-o sudo[17700]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 05:04:03 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="b3e66dc85ea2c87aca7db72b97d00dff"