-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Fri 2024-08-30 05:48:18 MSK. --
Aug 30 05:47:14 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 05:47:14 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 05:47:14 volumio volumio[834]: info: Discovery: Getting this device information
Aug 30 05:47:14 volumio volumio[834]: info: CoreCommandRouter::volumioGetState
Aug 30 05:47:14 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 05:47:35 volumio volumio[834]: info:
Aug 30 05:47:35 volumio volumio[834]: ---------------------------- MPD announces state update: player
Aug 30 05:47:35 volumio volumio[834]: info: ControllerMpd::getState
Aug 30 05:47:35 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status
Aug 30 05:47:35 volumio volumio[834]: info:
Aug 30 05:47:35 volumio volumio[834]: ---------------------------- MPD announces state update: player
Aug 30 05:47:35 volumio volumio[834]: info: ControllerMpd::getState
Aug 30 05:47:35 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status
Aug 30 05:47:35 volumio volumio[834]: info: sendMpdCommand status took 4 milliseconds
Aug 30 05:47:35 volumio volumio[834]: info: sendMpdCommand status took 2 milliseconds
Aug 30 05:47:35 volumio volumio[834]: verbose: ControllerMpd::parseState
Aug 30 05:47:35 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 30 05:47:35 volumio volumio[834]: verbose: ControllerMpd::parseState
Aug 30 05:47:35 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 30 05:47:35 volumio volumio[834]: info: sendMpdCommand playlistinfo took 2 milliseconds
Aug 30 05:47:35 volumio volumio[834]: info: sendMpdCommand playlistinfo took 2 milliseconds
Aug 30 05:47:35 volumio volumio[834]: verbose: ControllerMpd::parseTrackInfo
Aug 30 05:47:35 volumio volumio[834]: verbose: ControllerMpd::parseTrackInfo
Aug 30 05:47:35 volumio volumio[834]: info: ControllerMpd::pushState
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::servicePushState
Aug 30 05:47:35 volumio volumio[834]: verbose: In UPNP mode
Aug 30 05:47:35 volumio volumio[834]: verbose: STATE SERVICE {"status":"play","position":12,"seek":0,"duration":108,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"595 Kbps","isStreaming":false,"title":"Up And Away","artist":"Relaxing Chill Out Music, Adam Wiltshire (Composer), Relaxing Chill Out Music, Artist, MainArtist - Adam Wiltshire, Composer, Producer, Mixer - Ambient Nature White Noise, Artist (Performer)","album":"Ultimate Ambient Sleep Relaxation","uri":"http://192.168.2.141:57645/proxy/qobuz/D5357140F1BEB4FF2465E5B8AE69E070.flac","trackType":"qobuz"}
Aug 30 05:47:35 volumio volumio[834]: verbose: CURRENT POSITION 0
Aug 30 05:47:35 volumio volumio[834]: info: CoreStateMachine::syncState stateService play
Aug 30 05:47:35 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus play
Aug 30 05:47:35 volumio volumio[834]: info: Received an update from plugin. extracting info from payload
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Aug 30 05:47:35 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::volumioPushState
Aug 30 05:47:35 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::volumioPushState
Aug 30 05:47:35 volumio volumio[834]: info: ControllerMpd::pushState
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::servicePushState
Aug 30 05:47:35 volumio volumio[834]: verbose: In UPNP mode
Aug 30 05:47:35 volumio volumio[834]: verbose: STATE SERVICE {"status":"play","position":12,"seek":0,"duration":108,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"595 Kbps","isStreaming":false,"title":"Up And Away","artist":"Relaxing Chill Out Music, Adam Wiltshire (Composer), Relaxing Chill Out Music, Artist, MainArtist - Adam Wiltshire, Composer, Producer, Mixer - Ambient Nature White Noise, Artist (Performer)","album":"Ultimate Ambient Sleep Relaxation","uri":"http://192.168.2.141:57645/proxy/qobuz/D5357140F1BEB4FF2465E5B8AE69E070.flac","trackType":"qobuz"}
Aug 30 05:47:35 volumio volumio[834]: verbose: CURRENT POSITION 0
Aug 30 05:47:35 volumio volumio[834]: info: CoreStateMachine::syncState stateService play
Aug 30 05:47:35 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus play
Aug 30 05:47:35 volumio volumio[834]: info: Received an update from plugin. extracting info from payload
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Aug 30 05:47:35 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::volumioPushState
Aug 30 05:47:35 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::volumioPushState
Aug 30 05:47:35 volumio volumio[834]: info: ------------------------------ 30ms
Aug 30 05:47:35 volumio volumio[834]: info: ------------------------------ 28ms
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::volumioGetQueue
Aug 30 05:47:35 volumio volumio[834]: info: CoreStateMachine::getQueue
Aug 30 05:47:35 volumio volumio[834]: info: CorePlayQueue::getQueue
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::volumioGetQueue
Aug 30 05:47:35 volumio volumio[834]: info: CoreStateMachine::getQueue
Aug 30 05:47:35 volumio volumio[834]: info: CorePlayQueue::getQueue
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::volumioGetQueue
Aug 30 05:47:35 volumio volumio[834]: info: CoreStateMachine::getQueue
Aug 30 05:47:35 volumio volumio[834]: info: CorePlayQueue::getQueue
Aug 30 05:47:35 volumio volumio[834]: info: CoreCommandRouter::volumioGetQueue
Aug 30 05:47:35 volumio volumio[834]: info: CoreStateMachine::getQueue
Aug 30 05:47:35 volumio volumio[834]: info: CorePlayQueue::getQueue
Aug 30 05:47:44 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 05:47:44 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 05:47:44 volumio volumio[834]: info: Discovery: Getting this device information
Aug 30 05:47:44 volumio volumio[834]: info: CoreCommandRouter::volumioGetState
Aug 30 05:47:44 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 05:47:53 volumio volumio[834]: info: Starting UPNP Playback
Aug 30 05:47:53 volumio volumio[834]: info: Preparing playback through UPNP
Aug 30 05:47:53 volumio volumio[834]: info: Consume mode
Aug 30 05:47:53 volumio volumio[834]: info: CoreCommandRouter::volumioGetState
Aug 30 05:47:53 volumio volumio[834]: info: CoreStateMachine::setConsumeUpdateService mpd
Aug 30 05:47:53 volumio volumio[834]: info:
Aug 30 05:47:53 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:53 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:53 volumio volumio[834]: info:
Aug 30 05:47:53 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:53 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:53 volumio volumio[834]: info: ------------------------------ 5ms
Aug 30 05:47:53 volumio volumio[834]: info: ------------------------------ 4ms
Aug 30 05:47:53 volumio volumio[834]: info:
Aug 30 05:47:53 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:53 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:53 volumio volumio[834]: info:
Aug 30 05:47:53 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:53 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:53 volumio volumio[834]: info: ------------------------------ 5ms
Aug 30 05:47:53 volumio volumio[834]: info: ------------------------------ 4ms
Aug 30 05:47:53 volumio volumio[834]: info:
Aug 30 05:47:53 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:53 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:53 volumio volumio[834]: info:
Aug 30 05:47:53 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:53 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:53 volumio volumio[834]: info: ------------------------------ 4ms
Aug 30 05:47:53 volumio volumio[834]: info: ------------------------------ 3ms
Aug 30 05:47:53 volumio volumio[834]: info:
Aug 30 05:47:53 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:53 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:53 volumio volumio[834]: info:
Aug 30 05:47:53 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:53 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:53 volumio volumio[834]: info: ------------------------------ 5ms
Aug 30 05:47:53 volumio volumio[834]: info: ------------------------------ 4ms
Aug 30 05:47:53 volumio volumio[834]: info:
Aug 30 05:47:53 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:53 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:53 volumio volumio[834]: info:
Aug 30 05:47:53 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:53 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:53 volumio volumio[834]: info: ------------------------------ 7ms
Aug 30 05:47:53 volumio volumio[834]: info: ------------------------------ 6ms
Aug 30 05:47:53 volumio volumio[834]: info:
Aug 30 05:47:53 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:53 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:53 volumio volumio[834]: info:
Aug 30 05:47:53 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:53 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:53 volumio volumio[834]: info: ------------------------------ 4ms
Aug 30 05:47:53 volumio volumio[834]: info: ------------------------------ 4ms
Aug 30 05:47:57 volumio volumio[834]: info:
Aug 30 05:47:57 volumio volumio[834]: ---------------------------- MPD announces state update: player
Aug 30 05:47:57 volumio volumio[834]: info: ControllerMpd::getState
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status
Aug 30 05:47:57 volumio volumio[834]: info:
Aug 30 05:47:57 volumio volumio[834]: ---------------------------- MPD announces state update: player
Aug 30 05:47:57 volumio volumio[834]: info: ControllerMpd::getState
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status
Aug 30 05:47:57 volumio volumio[834]: info:
Aug 30 05:47:57 volumio volumio[834]: ---------------------------- MPD announces state update: player
Aug 30 05:47:57 volumio volumio[834]: info: sendMpdCommand status took 3 milliseconds
Aug 30 05:47:57 volumio volumio[834]: info: sendMpdCommand status took 4 milliseconds
Aug 30 05:47:57 volumio volumio[834]: info: ControllerMpd::getState
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::parseState
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::parseState
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 30 05:47:57 volumio volumio[834]: info: sendMpdCommand status took 1 milliseconds
Aug 30 05:47:57 volumio volumio[834]: info: sendMpdCommand playlistinfo took 1 milliseconds
Aug 30 05:47:57 volumio volumio[834]: info: sendMpdCommand playlistinfo took 1 milliseconds
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::parseState
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::parseTrackInfo
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::parseTrackInfo
Aug 30 05:47:57 volumio volumio[834]: info: ControllerMpd::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::servicePushState
Aug 30 05:47:57 volumio volumio[834]: verbose: In UPNP mode
Aug 30 05:47:57 volumio volumio[834]: verbose: STATE SERVICE {"status":"play","position":38,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Naim Classical","artist":null,"album":"SHOUTcast","uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Aug 30 05:47:57 volumio volumio[834]: verbose: CURRENT POSITION 0
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::syncState stateService play
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus play
Aug 30 05:47:57 volumio volumio[834]: info: Received an update from plugin. extracting info from payload
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::volumioPushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::volumioPushState
Aug 30 05:47:57 volumio volumio[834]: info: ControllerMpd::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::servicePushState
Aug 30 05:47:57 volumio volumio[834]: verbose: In UPNP mode
Aug 30 05:47:57 volumio volumio[834]: verbose: STATE SERVICE {"status":"play","position":38,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Naim Classical","artist":null,"album":"SHOUTcast","uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Aug 30 05:47:57 volumio volumio[834]: verbose: CURRENT POSITION 0
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::syncState stateService play
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus play
Aug 30 05:47:57 volumio volumio[834]: info: Received an update from plugin. extracting info from payload
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::volumioPushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::volumioPushState
Aug 30 05:47:57 volumio volumio[834]: info: ------------------------------ 27ms
Aug 30 05:47:57 volumio volumio[834]: info: ------------------------------ 27ms
Aug 30 05:47:57 volumio volumio[834]: info:
Aug 30 05:47:57 volumio volumio[834]: ---------------------------- MPD announces state update: player
Aug 30 05:47:57 volumio volumio[834]: info: ControllerMpd::getState
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status
Aug 30 05:47:57 volumio volumio[834]: info: sendMpdCommand playlistinfo took 23 milliseconds
Aug 30 05:47:57 volumio volumio[834]: info: sendMpdCommand status took 1 milliseconds
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::parseTrackInfo
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::parseState
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 30 05:47:57 volumio volumio[834]: info: ControllerMpd::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::servicePushState
Aug 30 05:47:57 volumio volumio[834]: verbose: In UPNP mode
Aug 30 05:47:57 volumio volumio[834]: verbose: STATE SERVICE {"status":"play","position":38,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Naim Classical","artist":null,"album":"SHOUTcast","uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Aug 30 05:47:57 volumio volumio[834]: verbose: CURRENT POSITION 0
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::syncState stateService play
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus play
Aug 30 05:47:57 volumio volumio[834]: info: Received an update from plugin. extracting info from payload
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::volumioPushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::volumioPushState
Aug 30 05:47:57 volumio volumio[834]: info: ------------------------------ 38ms
Aug 30 05:47:57 volumio volumio[834]: info: sendMpdCommand playlistinfo took 18 milliseconds
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::parseTrackInfo
Aug 30 05:47:57 volumio volumio[834]: info: ControllerMpd::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::servicePushState
Aug 30 05:47:57 volumio volumio[834]: verbose: In UPNP mode
Aug 30 05:47:57 volumio volumio[834]: verbose: STATE SERVICE {"status":"play","position":38,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Naim Classical","artist":null,"album":"SHOUTcast","uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Aug 30 05:47:57 volumio volumio[834]: verbose: CURRENT POSITION 0
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::syncState stateService play
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus play
Aug 30 05:47:57 volumio volumio[834]: info: Received an update from plugin. extracting info from payload
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::volumioPushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::volumioPushState
Aug 30 05:47:57 volumio volumio[834]: info: ------------------------------ 30ms
Aug 30 05:47:57 volumio volumio[834]: info:
Aug 30 05:47:57 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:57 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:57 volumio volumio[834]: info:
Aug 30 05:47:57 volumio volumio[834]: ---------------------------- MPD announces state update: player
Aug 30 05:47:57 volumio volumio[834]: info: ControllerMpd::getState
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status
Aug 30 05:47:57 volumio volumio[834]: info:
Aug 30 05:47:57 volumio volumio[834]: ---------------------------- MPD announces system playlist update
Aug 30 05:47:57 volumio volumio[834]: info: Ignoring MPD Status Update
Aug 30 05:47:57 volumio volumio[834]: info:
Aug 30 05:47:57 volumio volumio[834]: ---------------------------- MPD announces state update: player
Aug 30 05:47:57 volumio volumio[834]: info: ControllerMpd::getState
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status
Aug 30 05:47:57 volumio volumio[834]: info: ------------------------------ 6ms
Aug 30 05:47:57 volumio volumio[834]: info: sendMpdCommand status took 5 milliseconds
Aug 30 05:47:57 volumio volumio[834]: info: ------------------------------ 6ms
Aug 30 05:47:57 volumio volumio[834]: info: sendMpdCommand status took 5 milliseconds
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::parseState
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::parseState
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 30 05:47:57 volumio volumio[834]: info: sendMpdCommand playlistinfo took 1 milliseconds
Aug 30 05:47:57 volumio volumio[834]: info: sendMpdCommand playlistinfo took 1 milliseconds
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::parseTrackInfo
Aug 30 05:47:57 volumio volumio[834]: verbose: ControllerMpd::parseTrackInfo
Aug 30 05:47:57 volumio volumio[834]: info: ControllerMpd::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::servicePushState
Aug 30 05:47:57 volumio volumio[834]: verbose: In UPNP mode
Aug 30 05:47:57 volumio volumio[834]: verbose: STATE SERVICE {"status":"play","position":38,"seek":846,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":"Naim Classical","album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Aug 30 05:47:57 volumio volumio[834]: verbose: CURRENT POSITION 0
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::syncState stateService play
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus play
Aug 30 05:47:57 volumio volumio[834]: info: Received an update from plugin. extracting info from payload
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CorePlayQueue::getTrack 0
Aug 30 05:47:57 volumio volumio[834]: info: ControllerMpd::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::servicePushState
Aug 30 05:47:57 volumio volumio[834]: verbose: In UPNP mode
Aug 30 05:47:57 volumio volumio[834]: verbose: STATE SERVICE {"status":"play","position":38,"seek":846,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":"Naim Classical","album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Aug 30 05:47:57 volumio volumio[834]: verbose: CURRENT POSITION 0
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::syncState stateService play
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus play
Aug 30 05:47:57 volumio volumio[834]: info: Received an update from plugin. extracting info from payload
Aug 30 05:47:57 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Aug 30 05:47:57 volumio volumio[834]: info: CoreStateMachine::pushState
Aug 30 05:47:57 volumio volumio[834]: info: CorePlayQueue::getTrack 0
Aug 30 05:47:57 volumio volumio[834]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Aug 30 05:47:57 volumio volumio[834]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Aug 30 05:47:57 volumio volumio[834]: info: ------------------------------ 12ms
Aug 30 05:47:57 volumio volumio[834]: info: ------------------------------ 11ms
Aug 30 05:48:14 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 05:48:14 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 05:48:14 volumio volumio[834]: info: Discovery: Getting this device information
Aug 30 05:48:14 volumio volumio[834]: info: CoreCommandRouter::volumioGetState
Aug 30 05:48:14 volumio volumio[834]: info: CorePlayQueue::getTrack 0
Aug 30 05:48:14 volumio volumio[834]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Aug 30 05:48:14 volumio volumio[834]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48)
Aug 30 05:48:14 volumio volumio[834]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28)
Aug 30 05:48:14 volumio volumio[834]: at ControllerVolumioDiscovery.getThisDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:464:38)
Aug 30 05:48:14 volumio volumio[834]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1083:32)
Aug 30 05:48:14 volumio volumio[834]: at ControllerSystem.getSystemInfo (/volumio/app/plugins/system_controller/system/index.js:617:45)
Aug 30 05:48:14 volumio volumio[834]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1083:32)
Aug 30 05:48:14 volumio volumio[834]: at RESTApiSystem.getSystemInfo (/volumio/app/plugins/user_interface/rest_api/system.js:38:41)
Aug 30 05:48:14 volumio volumio[834]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Aug 30 05:48:14 volumio volumio[834]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Aug 30 05:48:14 volumio volumio[834]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Aug 30 05:48:14 volumio volumio[834]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Aug 30 05:48:14 volumio volumio[834]: at /volumio/node_modules/express/lib/router/index.js:281:22
Aug 30 05:48:14 volumio volumio[834]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Aug 30 05:48:14 volumio volumio[834]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Aug 30 05:48:14 volumio volumio[834]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Aug 30 05:48:14 volumio volumio[834]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Aug 30 05:48:14 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 05:48:14 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 05:48:14 volumio volumio[834]: info: Discovery: Getting this device information
Aug 30 05:48:14 volumio volumio[834]: info: CoreCommandRouter::volumioGetState
Aug 30 05:48:14 volumio volumio[834]: info: CorePlayQueue::getTrack 0
Aug 30 05:48:14 volumio volumio[834]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Aug 30 05:48:14 volumio volumio[834]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48)
Aug 30 05:48:14 volumio volumio[834]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28)
Aug 30 05:48:14 volumio volumio[834]: at ControllerVolumioDiscovery.getThisDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:464:38)
Aug 30 05:48:14 volumio volumio[834]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1083:32)
Aug 30 05:48:14 volumio volumio[834]: at ControllerSystem.getSystemInfo (/volumio/app/plugins/system_controller/system/index.js:617:45)
Aug 30 05:48:14 volumio volumio[834]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1083:32)
Aug 30 05:48:14 volumio volumio[834]: at RESTApiSystem.getSystemInfo (/volumio/app/plugins/user_interface/rest_api/system.js:38:41)
Aug 30 05:48:14 volumio volumio[834]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Aug 30 05:48:14 volumio volumio[834]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Aug 30 05:48:14 volumio volumio[834]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Aug 30 05:48:14 volumio volumio[834]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Aug 30 05:48:14 volumio volumio[834]: at /volumio/node_modules/express/lib/router/index.js:281:22
Aug 30 05:48:14 volumio volumio[834]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Aug 30 05:48:14 volumio volumio[834]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Aug 30 05:48:14 volumio volumio[834]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Aug 30 05:48:14 volumio volumio[834]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Aug 30 05:48:18 volumio volumio[834]: info: Starting UPNP Playback
Aug 30 05:48:18 volumio volumio[834]: info: Preparing playback through UPNP
Aug 30 05:48:18 volumio volumio[834]: info: Consume mode
Aug 30 05:48:18 volumio volumio[834]: info: CoreCommandRouter::volumioGetState
Aug 30 05:48:18 volumio volumio[834]: info: CorePlayQueue::getTrack 0
Aug 30 05:48:18 volumio volumio[834]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 30 05:48:18 volumio volumio[834]: TypeError: Cannot read property 'name' of undefined
Aug 30 05:48:18 volumio volumio[834]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48)
Aug 30 05:48:18 volumio volumio[834]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28)
Aug 30 05:48:18 volumio volumio[834]: at UpnpInterface.prepareUpnpPlayback (/volumio/app/plugins/audio_interface/upnp/index.js:257:34)
Aug 30 05:48:18 volumio volumio[834]: at Socket. (/volumio/app/plugins/audio_interface/upnp/index.js:44:14)
Aug 30 05:48:18 volumio volumio[834]: at Socket.emit (events.js:315:20)
Aug 30 05:48:18 volumio volumio[834]: at addChunk (internal/streams/readable.js:309:12)
Aug 30 05:48:18 volumio volumio[834]: at readableAddChunk (internal/streams/readable.js:280:11)
Aug 30 05:48:18 volumio volumio[834]: at Socket.Readable.push (internal/streams/readable.js:223:10)
Aug 30 05:48:18 volumio volumio[834]: at TCP.onStreamRead (internal/stream_base_commons.js:188:23)
Aug 30 05:48:18 volumio volumio[834]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 30 05:48:18 volumio sudo[11156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-30 05:47
Aug 30 05:48:18 volumio sudo[11156]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST"
VOLUMIO_VERSION="3.742"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"