-- Logs begin at Mon 2024-03-25 23:42:44 CET, end at Thu 2024-03-28 21:19:05 CET. -- Mar 28 21:18:07 volumio-henk-audio volumiologrotate[491]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Mar 28 21:18:07 volumio-henk-audio volumiologrotate[491]: ls: cannot access 'HENK-AUDIO': No such file or directory Mar 28 21:18:37 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 21:18:37 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 21:18:37 volumio-henk-audio volumio[30370]: info: Discovery: Getting this device information Mar 28 21:18:37 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioGetState Mar 28 21:18:37 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:37 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 21:18:37 volumio-henk-audio volumio[30370]: verbose: New Socket.io Connection to 192.168.5.185 from 192.168.5.143 UA: okhttp/4.9.2 Total Clients: 6 Mar 28 21:18:37 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioGetState Mar 28 21:18:37 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:37 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 28 21:18:37 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 28 21:18:40 volumio-henk-audio sudo[5139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 28 21:18:40 volumio-henk-audio sudo[5139]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 21:18:40 volumio-henk-audio sudo[5142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 21:18:40 volumio-henk-audio sudo[5139]: pam_unix(sudo:session): session closed for user root Mar 28 21:18:40 volumio-henk-audio sudo[5142]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 21:18:40 volumio-henk-audio sudo[5142]: pam_unix(sudo:session): session closed for user root Mar 28 21:18:40 volumio-henk-audio volumio[30370]: verbose: New Socket.io Connection to 192.168.5.185 from 192.168.5.143 UA: okhttp/4.9.2 Total Clients: 7 Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioGetVisibleSources Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioGetState Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: Received Get System Info Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: Discovery: Getting this device information Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioGetState Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioGetState Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: Listing playlists Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 28 21:18:40 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioPlay Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CoreStateMachine::play index undefined Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CoreStateMachine::startPlaybackTimer Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioGetVisibleSources Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: [1711657122353] ControllerWebradio::clearAddPlayTrack Mar 28 21:18:42 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::sendMpdCommand stop Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: sendMpdCommand stop took 1 milliseconds Mar 28 21:18:42 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::sendMpdCommand clear Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: Mar 28 21:18:42 volumio-henk-audio volumio[30370]: ---------------------------- MPD announces system playlist update Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: Ignoring MPD Status Update Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: sendMpdCommand clear took 2 milliseconds Mar 28 21:18:42 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::sendMpdCommand load "https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538.mp3?dist=tunein&DIST=TuneIn&TGT=TuneIn&maxServers=2&partnertok=eyJhbGciOiJIUzI1NiIsImtpZCI6InR1bmVpbiIsInR5cCI6IkpXVCJ9.eyJ0cnVzdGVkX3BhcnRuZXIiOnRydWUsImlhdCI6MTcxMTY0OTQwOCwiaXNzIjoidGlzcnYifQ.hX37JqaXOKkKTR05R0yu08HXRjKSiEltBwl4Lkmt6Qg" Mar 28 21:18:42 volumio-henk-audio volumio[30370]: error: updateQueue error: null Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: ------------------------------ 2ms Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: Received Get System Info Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: Discovery: Getting this device information Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioGetState Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:42 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 21:18:44 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 21:18:44 volumio-henk-audio volumio[30370]: info: Received Get System Info Mar 28 21:18:44 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 21:18:44 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 21:18:44 volumio-henk-audio volumio[30370]: info: Discovery: Getting this device information Mar 28 21:18:44 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioGetState Mar 28 21:18:44 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:44 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 21:18:45 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::sendMpdCommand add "https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538.mp3?dist=tunein&DIST=TuneIn&TGT=TuneIn&maxServers=2&partnertok=eyJhbGciOiJIUzI1NiIsImtpZCI6InR1bmVpbiIsInR5cCI6IkpXVCJ9.eyJ0cnVzdGVkX3BhcnRuZXIiOnRydWUsImlhdCI6MTcxMTY0OTQwOCwiaXNzIjoidGlzcnYifQ.hX37JqaXOKkKTR05R0yu08HXRjKSiEltBwl4Lkmt6Qg" Mar 28 21:18:45 volumio-henk-audio volumio[30370]: info: Mar 28 21:18:45 volumio-henk-audio volumio[30370]: ---------------------------- MPD announces system playlist update Mar 28 21:18:45 volumio-henk-audio volumio[30370]: info: Ignoring MPD Status Update Mar 28 21:18:45 volumio-henk-audio volumio[30370]: info: sendMpdCommand add "https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538.mp3?dist=tunein&DIST=TuneIn&TGT=TuneIn&maxServers=2&partnertok=eyJhbGciOiJIUzI1NiIsImtpZCI6InR1bmVpbiIsInR5cCI6IkpXVCJ9.eyJ0cnVzdGVkX3BhcnRuZXIiOnRydWUsImlhdCI6MTcxMTY0OTQwOCwiaXNzIjoidGlzcnYifQ.hX37JqaXOKkKTR05R0yu08HXRjKSiEltBwl4Lkmt6Qg" took 4 milliseconds Mar 28 21:18:45 volumio-henk-audio volumio[30370]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 28 21:18:45 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::sendMpdCommand play Mar 28 21:18:45 volumio-henk-audio volumio[30370]: info: ------------------------------ 1ms Mar 28 21:18:45 volumio-henk-audio volumio[30370]: info: sendMpdCommand play took 1 milliseconds Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: Mar 28 21:18:48 volumio-henk-audio volumio[30370]: ---------------------------- MPD announces state update: player Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: ControllerMpd::getState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::sendMpdCommand status Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: Mar 28 21:18:48 volumio-henk-audio volumio[30370]: ---------------------------- MPD announces state update: player Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: ControllerMpd::getState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::sendMpdCommand status Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: sendMpdCommand status took 1 milliseconds Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::parseState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: sendMpdCommand status took 1 milliseconds Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::parseState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::parseTrackInfo Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: ControllerMpd::pushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::servicePushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"RADIO538.mp3?dist=tunein&DIST=TuneIn&TGT=TuneIn&maxServers=2&partnertok=eyJhbGciOiJIUzI1NiIsImtpZCI6InR1bmVpbiIsInR5cCI6IkpXVCJ9.eyJ0cnVzdGVkX3BhcnRuZXIiOnRydWUsImlhdCI6MTcxMTY0OTQwOCwiaXNzIjoidGlzcnYifQ.hX37JqaXOKkKTR05R0yu08HXRjKSiEltBwl4Lkmt6Qg","artist":null,"album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538.mp3?dist=tunein&DIST=TuneIn&TGT=TuneIn&maxServers=2&partnertok=eyJhbGciOiJIUzI1NiIsImtpZCI6InR1bmVpbiIsInR5cCI6IkpXVCJ9.eyJ0cnVzdGVkX3BhcnRuZXIiOnRydWUsImlhdCI6MTcxMTY0OTQwOCwiaXNzIjoidGlzcnYifQ.hX37JqaXOKkKTR05R0yu08HXRjKSiEltBwl4Lkmt6Qg","trackType":""} Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: CURRENT POSITION 0 Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreStateMachine::syncState stateService play Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreStateMachine::syncState currentStatus stop Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: ------------------------------ 5ms Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::parseTrackInfo Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: ControllerMpd::pushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::servicePushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"RADIO538.mp3?dist=tunein&DIST=TuneIn&TGT=TuneIn&maxServers=2&partnertok=eyJhbGciOiJIUzI1NiIsImtpZCI6InR1bmVpbiIsInR5cCI6IkpXVCJ9.eyJ0cnVzdGVkX3BhcnRuZXIiOnRydWUsImlhdCI6MTcxMTY0OTQwOCwiaXNzIjoidGlzcnYifQ.hX37JqaXOKkKTR05R0yu08HXRjKSiEltBwl4Lkmt6Qg","artist":null,"album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538.mp3?dist=tunein&DIST=TuneIn&TGT=TuneIn&maxServers=2&partnertok=eyJhbGciOiJIUzI1NiIsImtpZCI6InR1bmVpbiIsInR5cCI6IkpXVCJ9.eyJ0cnVzdGVkX3BhcnRuZXIiOnRydWUsImlhdCI6MTcxMTY0OTQwOCwiaXNzIjoidGlzcnYifQ.hX37JqaXOKkKTR05R0yu08HXRjKSiEltBwl4Lkmt6Qg","trackType":""} Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: CURRENT POSITION 0 Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreStateMachine::syncState stateService play Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreStateMachine::syncState currentStatus play Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: Received an update from plugin. extracting info from payload Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreStateMachine::pushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioPushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: MRS: Pushing multiroomSync output update for this device Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: MRS: Pushing multiroomSync output Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreStateMachine::pushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioPushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: MRS: Pushing multiroomSync output update for this device Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: MRS: Pushing multiroomSync output Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: ------------------------------ 31ms Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: Mar 28 21:18:48 volumio-henk-audio volumio[30370]: ---------------------------- MPD announces system playlist update Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: Ignoring MPD Status Update Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: Mar 28 21:18:48 volumio-henk-audio volumio[30370]: ---------------------------- MPD announces state update: player Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: ControllerMpd::getState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::sendMpdCommand status Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: ------------------------------ 2ms Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: sendMpdCommand status took 6 milliseconds Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::parseState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::parseTrackInfo Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: ControllerMpd::pushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::servicePushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"RADIO538.mp3?dist=tunein&DIST=TuneIn&TGT=TuneIn&maxServers=2&partnertok=eyJhbGciOiJIUzI1NiIsImtpZCI6InR1bmVpbiIsInR5cCI6IkpXVCJ9.eyJ0cnVzdGVkX3BhcnRuZXIiOnRydWUsImlhdCI6MTcxMTY0OTQwOCwiaXNzIjoidGlzcnYifQ.hX37JqaXOKkKTR05R0yu08HXRjKSiEltBwl4Lkmt6Qg","artist":"538","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538.mp3?dist=tunein&DIST=TuneIn&TGT=TuneIn&maxServers=2&partnertok=eyJhbGciOiJIUzI1NiIsImtpZCI6InR1bmVpbiIsInR5cCI6IkpXVCJ9.eyJ0cnVzdGVkX3BhcnRuZXIiOnRydWUsImlhdCI6MTcxMTY0OTQwOCwiaXNzIjoidGlzcnYifQ.hX37JqaXOKkKTR05R0yu08HXRjKSiEltBwl4Lkmt6Qg","trackType":""} Mar 28 21:18:48 volumio-henk-audio volumio[30370]: verbose: CURRENT POSITION 0 Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreStateMachine::syncState stateService play Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreStateMachine::syncState currentStatus play Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: Received an update from plugin. extracting info from payload Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreStateMachine::pushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioPushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: MRS: Pushing multiroomSync output update for this device Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: MRS: Pushing multiroomSync output Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreStateMachine::pushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioPushState Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: MRS: Pushing multiroomSync output update for this device Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: MRS: Pushing multiroomSync output Mar 28 21:18:48 volumio-henk-audio volumio[30370]: info: ------------------------------ 29ms Mar 28 21:18:50 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioGetQueue Mar 28 21:18:50 volumio-henk-audio volumio[30370]: info: CoreStateMachine::getQueue Mar 28 21:18:50 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getQueue Mar 28 21:18:50 volumio-henk-audio volumio[30370]: info: Executing endpoint metavolumio Mar 28 21:18:50 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 28 21:18:50 volumio-henk-audio volumio[30370]: info: Executing endpoint metavolumio Mar 28 21:18:50 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 28 21:18:53 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 28 21:18:53 volumio-henk-audio volumio[30370]: info: Preload queue cleared Mar 28 21:18:56 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 28 21:18:56 volumio-henk-audio volumio[30370]: info: CURURI: music-library Mar 28 21:18:56 volumio-henk-audio volumio[30370]: info: Preload queue cleared Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: Received Get System Version Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: Received Get System Info Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: Discovery: Getting this device information Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioGetState Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: CURURI: music-library/USB Mar 28 21:18:59 volumio-henk-audio volumio[30370]: info: Preload queue cleared Mar 28 21:19:01 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 28 21:19:01 volumio-henk-audio volumio[30370]: info: CURURI: music-library/USB/6E6D-17B8 Mar 28 21:19:01 volumio-henk-audio volumio[30370]: info: Preload queue cleared Mar 28 21:19:04 volumio-henk-audio volumio[30370]: error: error Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: Preload queue cleared Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreStateMachine::ClearQueue Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreStateMachine::stop Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreStateMachine::stPlaybackTimer Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreStateMachine::updateTrackBlock Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrackBlock Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreStateMachine::pushState Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioPushState Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: MRS: Pushing multiroomSync output update for this device Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: MRS: Pushing multiroomSync output Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreStateMachine::serviceStop Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CorePlayQueue::getTrack 0 Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::serviceStop Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: [1711657145334] ControllerWebradio::stop Mar 28 21:19:05 volumio-henk-audio volumio[30370]: verbose: ControllerMpd::sendMpdCommand stop Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CorePlayQueue::clearPlayQueue Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CorePlayQueue::saveQueue Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreCommandRouter::volumioPushQueue Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CoreStateMachine::addQueueItems Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: CorePlayQueue::addQueueItems Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: Preload queue cleared Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: Adding Item to queue: music-library/USB/6E6D-17B8/Supertramp - Even In The Quietest Moments Vinyl LP 24-192 kHz] Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: Exploding uri music-library/USB/6E6D-17B8/Supertramp - Even In The Quietest Moments Vinyl LP 24-192 kHz] in service mpd Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: Mar 28 21:19:05 volumio-henk-audio volumio[30370]: ---------------------------- MPD announces state update: player Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: ALBUMART /albumart?cacheid=807&web=Supertramp/Even%20In%20The%20Quietest%20Moments.../extralarge&path=%2Fmnt%2FUSB%2F6E6D-17B8%2FSupertramp%20-%20Even%20In%20The%20Quietest%20Moments%20Vinyl%20LP%2024-192%20kHz%5D%2F01.%20Give%20A%20Little%20Bit.flac&metadata=false Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: URI /mnt/USB/6E6D-17B8/Supertramp - Even In The Quietest Moments Vinyl LP 24-192 kHz]/01. Give A Little Bit.flac Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: ALBUMART /albumart?cacheid=807&web=Supertramp/Even%20In%20The%20Quietest%20Moments.../extralarge&path=%2Fmnt%2FUSB%2F6E6D-17B8%2FSupertramp%20-%20Even%20In%20The%20Quietest%20Moments%20Vinyl%20LP%2024-192%20kHz%5D%2F02.%20Lover%20Boy.flac&metadata=false Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: URI /mnt/USB/6E6D-17B8/Supertramp - Even In The Quietest Moments Vinyl LP 24-192 kHz]/02. Lover Boy.flac Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: ALBUMART /albumart?cacheid=807&web=Supertramp/Even%20In%20The%20Quietest%20Moments.../extralarge&path=%2Fmnt%2FUSB%2F6E6D-17B8%2FSupertramp%20-%20Even%20In%20The%20Quietest%20Moments%20Vinyl%20LP%2024-192%20kHz%5D%2F03.%20Even%20In%20The%20Quietest%20Moments.flac&metadata=false Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: URI /mnt/USB/6E6D-17B8/Supertramp - Even In The Quietest Moments Vinyl LP 24-192 kHz]/03. Even In The Quietest Moments.flac Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: ALBUMART /albumart?cacheid=807&web=Supertramp/Even%20In%20The%20Quietest%20Moments.../extralarge&path=%2Fmnt%2FUSB%2F6E6D-17B8%2FSupertramp%20-%20Even%20In%20The%20Quietest%20Moments%20Vinyl%20LP%2024-192%20kHz%5D%2F04.%20Downstream.flac&metadata=false Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: URI /mnt/USB/6E6D-17B8/Supertramp - Even In The Quietest Moments Vinyl LP 24-192 kHz]/04. Downstream.flac Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: ALBUMART /albumart?cacheid=807&web=Supertramp/Even%20In%20The%20Quietest%20Moments.../extralarge&path=%2Fmnt%2FUSB%2F6E6D-17B8%2FSupertramp%20-%20Even%20In%20The%20Quietest%20Moments%20Vinyl%20LP%2024-192%20kHz%5D%2F05.%20Babaji.flac&metadata=false Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: URI /mnt/USB/6E6D-17B8/Supertramp - Even In The Quietest Moments Vinyl LP 24-192 kHz]/05. Babaji.flac Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: ALBUMART /albumart?cacheid=807&web=Supertramp/Even%20In%20The%20Quietest%20Moments.../extralarge&path=%2Fmnt%2FUSB%2F6E6D-17B8%2FSupertramp%20-%20Even%20In%20The%20Quietest%20Moments%20Vinyl%20LP%2024-192%20kHz%5D%2F06.%20From%20Now%20On.flac&metadata=false Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: URI /mnt/USB/6E6D-17B8/Supertramp - Even In The Quietest Moments Vinyl LP 24-192 kHz]/06. From Now On.flac Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: ALBUMART /albumart?cacheid=807&web=Supertramp/Even%20In%20The%20Quietest%20Moments.../extralarge&path=%2Fmnt%2FUSB%2F6E6D-17B8%2FSupertramp%20-%20Even%20In%20The%20Quietest%20Moments%20Vinyl%20LP%2024-192%20kHz%5D%2F07.%20Fool's%20Overture.flac&metadata=false Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: URI /mnt/USB/6E6D-17B8/Supertramp - Even In The Quietest Moments Vinyl LP 24-192 kHz]/07. Fool's Overture.flac Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: ALBUMART /albumart?cacheid=807&web=Supertramp/Even%20In%20The%20Quietest%20Moments.../extralarge&path=%2Fmnt%2FUSB%2F6E6D-17B8%2FSupertramp%20-%20Even%20In%20The%20Quietest%20Moments%20Vinyl%20LP%2024-192%20kHz%5D%2FEven%20In%20The%20Quietest%20Moments....flac.cue&metadata=false Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: URI /mnt/USB/6E6D-17B8/Supertramp - Even In The Quietest Moments Vinyl LP 24-192 kHz]/Even In The Quietest Moments....flac.cue Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: ALBUMART /albumart?cacheid=807&web=Supertramp/Even%20In%20The%20Quietest%20Moments.../extralarge&path=%2Fmnt%2FUSB%2F6E6D-17B8%2FSupertramp%20-%20Even%20In%20The%20Quietest%20Moments%20Vinyl%20LP%2024-192%20kHz%5D%2FEven%20In%20The%20Quietest%20Moments....flac.cue&metadata=false Mar 28 21:19:05 volumio-henk-audio volumio[30370]: info: URI /mnt/USB/6E6D-17B8/Supertramp - Even In The Quietest Moments Vinyl LP 24-192 kHz]/Even In The Quietest Moments....flac.cue Mar 28 21:19:05 volumio-henk-audio volumio[30370]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 21:19:05 volumio-henk-audio volumio[30370]: Error: Unable to resolve or reject the same promise twice Mar 28 21:19:05 volumio-henk-audio volumio[30370]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 28 21:19:05 volumio-henk-audio volumio[30370]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Mar 28 21:19:05 volumio-henk-audio volumio[30370]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Mar 28 21:19:05 volumio-henk-audio volumio[30370]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Mar 28 21:19:05 volumio-henk-audio volumio[30370]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Mar 28 21:19:05 volumio-henk-audio volumio[30370]: at Socket.emit (events.js:400:28) Mar 28 21:19:05 volumio-henk-audio volumio[30370]: at addChunk (internal/streams/readable.js:293:12) Mar 28 21:19:05 volumio-henk-audio volumio[30370]: at readableAddChunk (internal/streams/readable.js:263:11) Mar 28 21:19:05 volumio-henk-audio volumio[30370]: at Socket.Readable.push (internal/streams/readable.js:206:10) Mar 28 21:19:05 volumio-henk-audio volumio[30370]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Mar 28 21:19:05 volumio-henk-audio volumio[30370]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 21:19:05 volumio-henk-audio sudo[5173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-28 21:18 Mar 28 21:19:05 volumio-henk-audio sudo[5173]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e831866afe2db61aee9333a8f5ba9d9fd36609c7" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 18 Feb 2024 11:15:21 AM CET" VOLUMIO_VERSION="3.629" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="293a767fd1b71cabc5f5be4916f770a0"