-- Logs begin at Sat 2024-10-12 10:12:46 UTC, end at Sat 2024-10-12 10:23:00 UTC. --
Oct 12 10:22:23 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 10:22:23 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 10:22:23 volumiosynology volumio[820]: info: Discovery: Getting this device information
Oct 12 10:22:23 volumiosynology volumio[820]: info: CoreCommandRouter::volumioGetState
Oct 12 10:22:23 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:23 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 12 10:22:24 volumiosynology volumio[820]: info: [jellyfin-poller] Polled https://jellyfin.endinas.synologu.me: offline
Oct 12 10:22:44 volumiosynology volumio[820]: info: Clearing queue after UPNP request
Oct 12 10:22:44 volumiosynology volumio[820]: info: CoreStateMachine::ClearQueue
Oct 12 10:22:44 volumiosynology volumio[820]: info: CoreStateMachine::stop
Oct 12 10:22:44 volumiosynology volumio[820]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 10:22:44 volumiosynology volumio[820]: info: CorePlayQueue::clearPlayQueue
Oct 12 10:22:44 volumiosynology volumio[820]: info: CorePlayQueue::saveQueue
Oct 12 10:22:44 volumiosynology volumio[820]: info: CoreCommandRouter::volumioPushState
Oct 12 10:22:44 volumiosynology volumio[820]: info: CoreCommandRouter::volumioPushQueue
Oct 12 10:22:44 volumiosynology volumio[820]: error: Upnp client error: Error: This socket has been ended by the other party
Oct 12 10:22:44 volumiosynology volumio[820]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Oct 12 10:22:46 volumiosynology volumio[820]: info: Starting UPNP Playback
Oct 12 10:22:46 volumiosynology volumio[820]: info: Preparing playback through UPNP
Oct 12 10:22:46 volumiosynology volumio[820]: info: CoreCommandRouter::volumioGetState
Oct 12 10:22:46 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:46 volumiosynology volumio[820]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 6ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 4ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 3ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 2ms
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 7ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 5ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 3ms
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 5ms
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 6ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 5ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 4ms
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 6ms
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 8ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 6ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 5ms
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 9ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 6ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 5ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 4ms
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info:
Oct 12 10:22:46 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:46 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 6ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 4ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 5ms
Oct 12 10:22:46 volumiosynology volumio[820]: info: ------------------------------ 6ms
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 16 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 14 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 13 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 5 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Oct 12 10:22:47 volumiosynology volumio[820]: info: FusionDsp - ---- read samplerate from file: 44100
Oct 12 10:22:47 volumiosynology volumio[820]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:47 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:47 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 72 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 71 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 67 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 66 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 64 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 52 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 41 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 39 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseTrackInfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseTrackInfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseTrackInfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseTrackInfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus stop
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 144ms
Oct 12 10:22:47 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:47 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:47 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 143ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 142ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 138ms
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:47 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:47 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:47 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 89ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 79 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 85ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 75 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 74 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 76 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 71 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 28ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 27 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 27ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 25 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 21ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 18 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseTrackInfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseTrackInfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseTrackInfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseTrackInfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":466,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":1359,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":1359,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":1359,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:47 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:47 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:47 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 210ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 197ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 172ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 167ms
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces system playlist update
Oct 12 10:22:47 volumiosynology volumio[820]: info: Ignoring MPD Status Update
Oct 12 10:22:47 volumiosynology volumio[820]: info:
Oct 12 10:22:47 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 50 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 54 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 52 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 51 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 13ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand status took 8 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseTrackInfo
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":1484,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":1484,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":1609,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":1609,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":1609,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:47 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 204ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 203ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 140ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 137ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 130ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 47 milliseconds
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: ControllerMpd::parseTrackInfo
Oct 12 10:22:47 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: In UPNP mode
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: STATE SERVICE {"status":"play","position":1,"seek":1860,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"tuba10-1.mp3","artist":"TOK.FM","album":null,"uri":"http://radiostream.pl/tuba10-1.mp3","trackType":"mp3"}
Oct 12 10:22:47 volumiosynology volumio[820]: verbose: CURRENT POSITION 0
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState stateService play
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::syncState currentStatus play
Oct 12 10:22:47 volumiosynology volumio[820]: info: Received an update from plugin. extracting info from payload
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 12 10:22:47 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:47 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:47 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:47 volumiosynology volumio[820]: info: ------------------------------ 70ms
Oct 12 10:22:47 volumiosynology volumio[820]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Oct 12 10:22:53 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 10:22:53 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 10:22:53 volumiosynology volumio[820]: info: Discovery: Getting this device information
Oct 12 10:22:53 volumiosynology volumio[820]: info: CoreCommandRouter::volumioGetState
Oct 12 10:22:53 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:53 volumiosynology volumio[820]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:53 volumiosynology volumio[820]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48)
Oct 12 10:22:53 volumiosynology volumio[820]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28)
Oct 12 10:22:53 volumiosynology volumio[820]: at ControllerVolumioDiscovery.getThisDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:464:38)
Oct 12 10:22:53 volumiosynology volumio[820]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1083:32)
Oct 12 10:22:53 volumiosynology volumio[820]: at ControllerSystem.getSystemInfo (/volumio/app/plugins/system_controller/system/index.js:617:45)
Oct 12 10:22:53 volumiosynology volumio[820]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1083:32)
Oct 12 10:22:53 volumiosynology volumio[820]: at RESTApiSystem.getSystemInfo (/volumio/app/plugins/user_interface/rest_api/system.js:38:41)
Oct 12 10:22:53 volumiosynology volumio[820]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Oct 12 10:22:53 volumiosynology volumio[820]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Oct 12 10:22:53 volumiosynology volumio[820]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Oct 12 10:22:53 volumiosynology volumio[820]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Oct 12 10:22:53 volumiosynology volumio[820]: at /volumio/node_modules/express/lib/router/index.js:281:22
Oct 12 10:22:53 volumiosynology volumio[820]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Oct 12 10:22:53 volumiosynology volumio[820]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Oct 12 10:22:53 volumiosynology volumio[820]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Oct 12 10:22:53 volumiosynology volumio[820]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Oct 12 10:22:53 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 10:22:53 volumiosynology volumio[820]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 10:22:53 volumiosynology volumio[820]: info: Discovery: Getting this device information
Oct 12 10:22:53 volumiosynology volumio[820]: info: CoreCommandRouter::volumioGetState
Oct 12 10:22:53 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:53 volumiosynology volumio[820]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:53 volumiosynology volumio[820]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48)
Oct 12 10:22:53 volumiosynology volumio[820]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28)
Oct 12 10:22:53 volumiosynology volumio[820]: at ControllerVolumioDiscovery.getThisDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:464:38)
Oct 12 10:22:53 volumiosynology volumio[820]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1083:32)
Oct 12 10:22:53 volumiosynology volumio[820]: at ControllerSystem.getSystemInfo (/volumio/app/plugins/system_controller/system/index.js:617:45)
Oct 12 10:22:53 volumiosynology volumio[820]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1083:32)
Oct 12 10:22:53 volumiosynology volumio[820]: at RESTApiSystem.getSystemInfo (/volumio/app/plugins/user_interface/rest_api/system.js:38:41)
Oct 12 10:22:53 volumiosynology volumio[820]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Oct 12 10:22:53 volumiosynology volumio[820]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Oct 12 10:22:53 volumiosynology volumio[820]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Oct 12 10:22:53 volumiosynology volumio[820]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Oct 12 10:22:53 volumiosynology volumio[820]: at /volumio/node_modules/express/lib/router/index.js:281:22
Oct 12 10:22:53 volumiosynology volumio[820]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Oct 12 10:22:53 volumiosynology volumio[820]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Oct 12 10:22:53 volumiosynology volumio[820]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Oct 12 10:22:53 volumiosynology volumio[820]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Oct 12 10:22:54 volumiosynology volumio[820]: info: [jellyfin-poller] Polled https://jellyfin.endinas.synologu.me: offline
Oct 12 10:22:58 volumiosynology volumio[820]: info:
Oct 12 10:22:58 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:58 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:58 volumiosynology volumio[820]: info:
Oct 12 10:22:58 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:58 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:58 volumiosynology volumio[820]: info:
Oct 12 10:22:58 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:58 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:58 volumiosynology volumio[820]: info:
Oct 12 10:22:58 volumiosynology volumio[820]: ---------------------------- MPD announces state update: player
Oct 12 10:22:58 volumiosynology volumio[820]: info: ControllerMpd::getState
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 10:22:58 volumiosynology volumio[820]: info: sendMpdCommand status took 8 milliseconds
Oct 12 10:22:58 volumiosynology volumio[820]: info: sendMpdCommand status took 7 milliseconds
Oct 12 10:22:58 volumiosynology volumio[820]: info: sendMpdCommand status took 2 milliseconds
Oct 12 10:22:58 volumiosynology volumio[820]: info: sendMpdCommand status took 1 milliseconds
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::parseState
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 10:22:58 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 11 milliseconds
Oct 12 10:22:58 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 11 milliseconds
Oct 12 10:22:58 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 11 milliseconds
Oct 12 10:22:58 volumiosynology volumio[820]: info: sendMpdCommand playlistinfo took 11 milliseconds
Oct 12 10:22:58 volumiosynology volumio[820]: verbose: ControllerMpd::parseTrackInfo
Oct 12 10:22:58 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:58 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:58 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:58 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:58 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:58 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:58 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:58 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:58 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:58 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:58 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:58 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:58 volumiosynology volumio[820]: info: ControllerMpd::pushState
Oct 12 10:22:58 volumiosynology volumio[820]: info: CoreCommandRouter::servicePushState
Oct 12 10:22:58 volumiosynology volumio[820]: info: CoreStateMachine::pushState
Oct 12 10:22:58 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:22:58 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:58 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:58 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:58 volumiosynology volumio[820]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Oct 12 10:22:58 volumiosynology volumio[820]: info: ------------------------------ 38ms
Oct 12 10:22:58 volumiosynology volumio[820]: info: ------------------------------ 35ms
Oct 12 10:22:58 volumiosynology volumio[820]: info: ------------------------------ 32ms
Oct 12 10:22:58 volumiosynology volumio[820]: info: ------------------------------ 30ms
Oct 12 10:22:58 volumiosynology volumio[820]: info: camilladsp spawned new process with pid 2449, instance 1, run: true
Oct 12 10:23:00 volumiosynology volumio[820]: info: Airplay started streaming, receiving metadatas
Oct 12 10:23:00 volumiosynology volumio[820]: info: CorePlayQueue::getTrack 0
Oct 12 10:23:00 volumiosynology volumio[820]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 12 10:23:00 volumiosynology volumio[820]: TypeError: Cannot read property 'name' of undefined
Oct 12 10:23:00 volumiosynology volumio[820]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48)
Oct 12 10:23:00 volumiosynology volumio[820]: at AirPlayInterface.prepareAirplayPlayback (/volumio/app/plugins/music_service/airplay_emulation/index.js:538:47)
Oct 12 10:23:00 volumiosynology volumio[820]: at ShairportSyncReaderUDP. (/volumio/app/plugins/music_service/airplay_emulation/index.js:257:12)
Oct 12 10:23:00 volumiosynology volumio[820]: at ShairportSyncReaderUDP.emit (events.js:412:35)
Oct 12 10:23:00 volumiosynology volumio[820]: at ShairportSyncReaderUDP.useData (/volumio/app/plugins/music_service/airplay_emulation/shairport-sync-reader/shairport-sync-reader-base.js:86:16)
Oct 12 10:23:00 volumiosynology volumio[820]: at Socket. (/volumio/app/plugins/music_service/airplay_emulation/shairport-sync-reader/shairport-sync-reader-udp.js:21:12)
Oct 12 10:23:00 volumiosynology volumio[820]: at Socket.emit (events.js:400:28)
Oct 12 10:23:00 volumiosynology volumio[820]: at UDP.onMessage [as onmessage] (dgram.js:931:8)
Oct 12 10:23:00 volumiosynology volumio[820]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 12 10:23:00 volumiosynology shairport-sync[1516]: % Total % Received % Xferd Average Speed Time Time Time Current
Oct 12 10:23:00 volumiosynology shairport-sync[1516]: Dload Upload Total Spent Left Speed
Oct 12 10:23:00 volumiosynology sudo[2474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-12 10:22
Oct 12 10:23:00 volumiosynology sudo[2474]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST"
VOLUMIO_VERSION="3.757"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"