-- Logs begin at Sat 2025-03-01 11:05:21 CET, end at Mon 2025-03-03 22:33:13 CET. -- Mar 03 22:32:02 pva-group-d.o.o go-librespot[1848]: time="2025-03-03T22:32:02+01:00" level=trace msg="sent dealer ping" Mar 03 22:32:02 pva-group-d.o.o go-librespot[1848]: time="2025-03-03T22:32:02+01:00" level=trace msg="received dealer pong" Mar 03 22:32:25 pva-group-d.o.o volumiologrotate[719]: ls: cannot access '/var/log/samba/log.wb-PVA': No such file or directory Mar 03 22:32:25 pva-group-d.o.o volumiologrotate[719]: ls: cannot access 'GROUP': No such file or directory Mar 03 22:32:25 pva-group-d.o.o volumiologrotate[719]: ls: cannot access 'D.O.O': No such file or directory Mar 03 22:32:32 pva-group-d.o.o go-librespot[1848]: time="2025-03-03T22:32:32+01:00" level=trace msg="sent dealer ping" Mar 03 22:32:32 pva-group-d.o.o go-librespot[1848]: time="2025-03-03T22:32:32+01:00" level=trace msg="received dealer pong" Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces state update: player Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: ControllerMpd::getState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand status Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces state update: player Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: ControllerMpd::getState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand status Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces state update: player Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: ControllerMpd::getState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand status Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: sendMpdCommand status took 3 milliseconds Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: sendMpdCommand status took 3 milliseconds Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: sendMpdCommand status took 2 milliseconds Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseTrackInfo Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseTrackInfo Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseTrackInfo Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: ControllerMpd::pushState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::servicePushState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: ControllerMpd::pushState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::servicePushState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: ControllerMpd::pushState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::servicePushState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: ------------------------------ 15ms Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: ------------------------------ 14ms Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: ------------------------------ 13ms Mar 03 22:32:45 pva-group-d.o.o volumio[1359]: info: Clearing queue after UPNP request Mar 03 22:32:45 pva-group-d.o.o ntpd[10542]: Soliciting pool server 2001:648:2ffc:1225:a800:bff:fe10:88ce Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::ClearQueue Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::stop Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::stPlaybackTimer Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::updateTrackBlock Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrackBlock Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::volumioPushState Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::serviceStop Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ControllerMpd::stop Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand stop Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::clearPlayQueue Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::saveQueue Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::volumioPushState Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::volumioPushQueue Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: sendMpdCommand stop took 16 milliseconds Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: error: updateQueue error: null Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 2ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: error: updateQueue error: null Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: error: updateQueue error: null Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 3ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 2ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Starting UPNP Playback Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Preparing playback through UPNP Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::volumioGetState Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 3ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 3ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 2ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 4ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 3ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 3ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 4ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 3ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 3ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 2ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 3ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 2ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 1ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 4ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 3ms Mar 03 22:32:46 pva-group-d.o.o volumio[1359]: info: ------------------------------ 2ms Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces state update: player Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ControllerMpd::getState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand status Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces state update: player Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ControllerMpd::getState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand status Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces state update: player Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ControllerMpd::getState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand status Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: sendMpdCommand status took 3 milliseconds Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: sendMpdCommand status took 2 milliseconds Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: sendMpdCommand status took 3 milliseconds Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseTrackInfo Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseTrackInfo Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ControllerMpd::pushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::servicePushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: In UPNP mode Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"RADIO S JUZNI","artist":null,"album":null,"uri":"https://stream.radios.rs:9038","trackType":"rs:9038"} Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: CURRENT POSITION 0 Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::syncState stateService play Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::syncState currentStatus stop Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ControllerMpd::pushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::servicePushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: In UPNP mode Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"RADIO S JUZNI","artist":null,"album":null,"uri":"https://stream.radios.rs:9038","trackType":"rs:9038"} Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: CURRENT POSITION 0 Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::syncState stateService play Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::syncState currentStatus play Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Received an update from plugin. extracting info from payload Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::volumioPushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::volumioPushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ------------------------------ 36ms Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ------------------------------ 38ms Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces state update: player Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: sendMpdCommand playlistinfo took 33 milliseconds Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ControllerMpd::getState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand status Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseTrackInfo Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ControllerMpd::pushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::servicePushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: In UPNP mode Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.radios.rs:9038","artist":"Radio S Juzni","album":null,"uri":"https://stream.radios.rs:9038","trackType":"rs:9038"} Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: CURRENT POSITION 0 Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::syncState stateService play Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::syncState currentStatus play Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Received an update from plugin. extracting info from payload Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ------------------------------ 44ms Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces system playlist update Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Ignoring MPD Status Update Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ------------------------------ 11ms Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: sendMpdCommand status took 10 milliseconds Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ------------------------------ 5ms Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ------------------------------ 5ms Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces state update: player Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ControllerMpd::getState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand status Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: ---------------------------- MPD announces state update: player Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ControllerMpd::getState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand status Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: sendMpdCommand status took 2 milliseconds Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: sendMpdCommand status took 1 milliseconds Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseTrackInfo Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ControllerMpd::pushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::servicePushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: In UPNP mode Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"30 Kbps","isStreaming":false,"title":"stream.radios.rs:9038","artist":"Radio S Juzni","album":null,"uri":"https://stream.radios.rs:9038","trackType":"rs:9038"} Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: CURRENT POSITION 0 Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::syncState stateService play Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::syncState currentStatus play Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Received an update from plugin. extracting info from payload Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ------------------------------ 26ms Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: sendMpdCommand playlistinfo took 11 milliseconds Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: ControllerMpd::parseTrackInfo Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ControllerMpd::pushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::servicePushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: In UPNP mode Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"30 Kbps","isStreaming":false,"title":"stream.radios.rs:9038","artist":"Radio S Juzni","album":null,"uri":"https://stream.radios.rs:9038","trackType":"rs:9038"} Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: CURRENT POSITION 0 Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::syncState stateService play Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::syncState currentStatus play Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Received an update from plugin. extracting info from payload Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ControllerMpd::pushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::servicePushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: In UPNP mode Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"30 Kbps","isStreaming":false,"title":"stream.radios.rs:9038","artist":"Radio S Juzni","album":null,"uri":"https://stream.radios.rs:9038","trackType":"rs:9038"} Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: verbose: CURRENT POSITION 0 Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::syncState stateService play Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::syncState currentStatus play Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: Received an update from plugin. extracting info from payload Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ------------------------------ 19ms Mar 03 22:32:47 pva-group-d.o.o volumio[1359]: info: ------------------------------ 18ms Mar 03 22:32:54 pva-group-d.o.o volumio[1928]: 100 Mar 03 22:32:54 pva-group-d.o.o volumio[1928]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 03 22:32:54 pva-group-d.o.o volumio[1928]: Dload Upload Total Spent Left Speed Mar 03 22:32:54 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:54 pva-group-d.o.o volumio[1359]: ---------------------------- Client requests Volume 100 Mar 03 22:32:54 pva-group-d.o.o volumio[1359]: info: VolumeController::SetAlsaVolume100 Mar 03 22:32:54 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:54 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:54 pva-group-d.o.o volumio[1928]: [158B blob data] Mar 03 22:32:54 pva-group-d.o.o volumio[1928]: {"time":1741037574660,"response":"volume Success"}100 Mar 03 22:32:57 pva-group-d.o.o volumio[1928]: 90 Mar 03 22:32:57 pva-group-d.o.o volumio[1928]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 03 22:32:57 pva-group-d.o.o volumio[1928]: Dload Upload Total Spent Left Speed Mar 03 22:32:57 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:57 pva-group-d.o.o volumio[1359]: ---------------------------- Client requests Volume 90 Mar 03 22:32:57 pva-group-d.o.o volumio[1359]: info: VolumeController::SetAlsaVolume90 Mar 03 22:32:57 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:57 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:57 pva-group-d.o.o volumio[1928]: [158B blob data] Mar 03 22:32:57 pva-group-d.o.o volumio[1928]: {"time":1741037577786,"response":"volume Success"}90 Mar 03 22:32:58 pva-group-d.o.o volumio[1928]: 40 Mar 03 22:32:58 pva-group-d.o.o volumio[1928]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 03 22:32:58 pva-group-d.o.o volumio[1928]: Dload Upload Total Spent Left Speed Mar 03 22:32:58 pva-group-d.o.o volumio[1359]: info: Mar 03 22:32:58 pva-group-d.o.o volumio[1359]: ---------------------------- Client requests Volume 40 Mar 03 22:32:58 pva-group-d.o.o volumio[1359]: info: VolumeController::SetAlsaVolume40 Mar 03 22:32:58 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:32:58 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:32:58 pva-group-d.o.o volumio[1928]: [158B blob data] Mar 03 22:32:58 pva-group-d.o.o volumio[1928]: {"time":1741037578684,"response":"volume Success"}40 Mar 03 22:33:02 pva-group-d.o.o volumio[1928]: 50 Mar 03 22:33:02 pva-group-d.o.o volumio[1928]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 03 22:33:02 pva-group-d.o.o volumio[1928]: Dload Upload Total Spent Left Speed Mar 03 22:33:02 pva-group-d.o.o volumio[1359]: info: Mar 03 22:33:02 pva-group-d.o.o volumio[1359]: ---------------------------- Client requests Volume 50 Mar 03 22:33:02 pva-group-d.o.o volumio[1359]: info: VolumeController::SetAlsaVolume50 Mar 03 22:33:02 pva-group-d.o.o volumio[1359]: info: CoreStateMachine::pushState Mar 03 22:33:02 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:33:02 pva-group-d.o.o volumio[1928]: [158B blob data] Mar 03 22:33:02 pva-group-d.o.o volumio[1928]: {"time":1741037582119,"response":"volume Success"}50 Mar 03 22:33:02 pva-group-d.o.o go-librespot[1848]: time="2025-03-03T22:33:02+01:00" level=trace msg="sent dealer ping" Mar 03 22:33:02 pva-group-d.o.o go-librespot[1848]: time="2025-03-03T22:33:02+01:00" level=trace msg="received dealer pong" Mar 03 22:33:12 pva-group-d.o.o sudo[22238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 03 22:33:12 pva-group-d.o.o sudo[22238]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 22:33:12 pva-group-d.o.o sudo[22238]: pam_unix(sudo:session): session closed for user root Mar 03 22:33:12 pva-group-d.o.o sudo[22241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 03 22:33:12 pva-group-d.o.o sudo[22241]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 22:33:12 pva-group-d.o.o sudo[22241]: pam_unix(sudo:session): session closed for user root Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: verbose: New Socket.io Connection to 192.168.80.237 from 192.168.80.42 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 03 22:33:12 pva-group-d.o.o sudo[22246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 03 22:33:12 pva-group-d.o.o sudo[22246]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 22:33:12 pva-group-d.o.o sudo[22246]: pam_unix(sudo:session): session closed for user root Mar 03 22:33:12 pva-group-d.o.o sudo[22249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 03 22:33:12 pva-group-d.o.o sudo[22249]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 03 22:33:12 pva-group-d.o.o sudo[22249]: pam_unix(sudo:session): session closed for user root Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: verbose: New Socket.io Connection to 192.168.80.237 from 192.168.80.42 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::volumioGetVisibleSources Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: info: CoreCommandRouter::volumioGetState Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: info: CorePlayQueue::getTrack 0 Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: TypeError: Cannot read property 'name' of undefined Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:58:38) Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: at Socket.emit (events.js:400:28) Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Mar 03 22:33:12 pva-group-d.o.o volumio[1359]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 22:33:13 pva-group-d.o.o sudo[22260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-03 22:32 Mar 03 22:33:13 pva-group-d.o.o sudo[22260]: 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="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"