Feb 08 00:47:00 volumio volumio[1118]: info: CoreCommandRouter::volumioStop
Feb 08 00:47:00 volumio volumio[1118]: info: CoreStateMachine::stop
Feb 08 00:47:00 volumio volumio[1118]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 08 00:47:00 volumio volumio[1118]: info: CoreStateMachine::stPlaybackTimer
Feb 08 00:47:00 volumio volumio[1118]: info: CoreStateMachine::updateTrackBlock
Feb 08 00:47:00 volumio volumio[1118]: info: CorePlayQueue::getTrackBlock
Feb 08 00:47:00 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:00 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:00 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:00 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:00 volumio volumio[1118]: info: CoreStateMachine::serviceStop
Feb 08 00:47:00 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:00 volumio volumio[1118]: info: CoreCommandRouter::serviceStop
Feb 08 00:47:00 volumio volumio[1118]: info: [1770508020164] ControllerWebradio::stop
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand stop
Feb 08 00:47:00 volumio volumio[1118]: info:
Feb 08 00:47:00 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:00 volumio volumio[1118]: info: sendMpdCommand stop took 9 milliseconds
Feb 08 00:47:00 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:00 volumio volumio[1118]: info:
Feb 08 00:47:00 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:00 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:00 volumio volumio[1118]: info:
Feb 08 00:47:00 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:00 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:00 volumio volumio[1118]: info: sendMpdCommand status took 4 milliseconds
Feb 08 00:47:00 volumio volumio[1118]: info: sendMpdCommand status took 4 milliseconds
Feb 08 00:47:00 volumio volumio[1118]: info: sendMpdCommand status took 3 milliseconds
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:00 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 08 00:47:00 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 08 00:47:00 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:00 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:00 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:00 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:00 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:00 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:00 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:00 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:00 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:00 volumio volumio[1118]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Feb 08 00:47:00 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:00 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:00 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:00 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:00 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:00 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:00 volumio volumio[1118]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Feb 08 00:47:00 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:00 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:00 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:00 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:00 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:00 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:00 volumio volumio[1118]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Feb 08 00:47:00 volumio volumio[1118]: info: ------------------------------ 25ms
Feb 08 00:47:00 volumio volumio[1118]: info: ------------------------------ 25ms
Feb 08 00:47:00 volumio volumio[1118]: info: ------------------------------ 24ms
Feb 08 00:47:03 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 08 00:47:06 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 08 00:47:07 volumio volumio[1118]: info: CoreCommandRouter::volumioPlay
Feb 08 00:47:07 volumio volumio[1118]: info: CoreStateMachine::play index undefined
Feb 08 00:47:07 volumio volumio[1118]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 08 00:47:07 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:07 volumio volumio[1118]: info: CoreStateMachine::startPlaybackTimer
Feb 08 00:47:07 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:07 volumio volumio[1118]: info: [1770508027825] ControllerWebradio::clearAddPlayTrack
Feb 08 00:47:07 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand stop
Feb 08 00:47:07 volumio volumio[1118]: info: sendMpdCommand stop took 2 milliseconds
Feb 08 00:47:07 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand clear
Feb 08 00:47:07 volumio volumio[1118]: info:
Feb 08 00:47:07 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:47:07 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:47:07 volumio volumio[1118]: info: sendMpdCommand clear took 3 milliseconds
Feb 08 00:47:07 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99616827"
Feb 08 00:47:07 volumio volumio[1118]: info:
Feb 08 00:47:07 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:47:07 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:47:07 volumio volumio[1118]: info:
Feb 08 00:47:07 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:47:07 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:47:07 volumio volumio[1118]: error: updateQueue error: null
Feb 08 00:47:07 volumio volumio[1118]: info:
Feb 08 00:47:07 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:47:07 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:47:07 volumio volumio[1118]: info: ------------------------------ 138ms
Feb 08 00:47:07 volumio volumio[1118]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99616827" took 137 milliseconds
Feb 08 00:47:07 volumio volumio[1118]: info: ------------------------------ 137ms
Feb 08 00:47:07 volumio volumio[1118]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 08 00:47:07 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand play
Feb 08 00:47:07 volumio volumio[1118]: info:
Feb 08 00:47:07 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:47:07 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:47:07 volumio volumio[1118]: info:
Feb 08 00:47:07 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:47:07 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:47:07 volumio volumio[1118]: info: ------------------------------ 142ms
Feb 08 00:47:07 volumio volumio[1118]: info: ------------------------------ 9ms
Feb 08 00:47:07 volumio volumio[1118]: info: sendMpdCommand play took 6 milliseconds
Feb 08 00:47:07 volumio volumio[1118]: info: ------------------------------ 6ms
Feb 08 00:47:07 volumio volumio[1118]: info: ------------------------------ 4ms
Feb 08 00:47:08 volumio volumio[1118]: info:
Feb 08 00:47:08 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:08 volumio volumio[1118]: info:
Feb 08 00:47:08 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:08 volumio volumio[1118]: info:
Feb 08 00:47:08 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:08 volumio volumio[1118]: info:
Feb 08 00:47:08 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand status took 9 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand status took 8 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand status took 7 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:08 volumio volumio[1118]: info:
Feb 08 00:47:08 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:08 volumio volumio[1118]: info:
Feb 08 00:47:08 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:08 volumio volumio[1118]: info:
Feb 08 00:47:08 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:47:08 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:47:08 volumio volumio[1118]: info:
Feb 08 00:47:08 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand status took 11 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 12 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 13 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 12 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand status took 9 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:08 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:08 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 1010/8500) OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:47:08 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus stop
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:08 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:08 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 1010/8500) OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:47:08 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:47:08 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:08 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:08 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 1010/8500) OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:47:08 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:47:08 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: ------------------------------ 45ms
Feb 08 00:47:08 volumio volumio[1118]: info: ------------------------------ 51ms
Feb 08 00:47:08 volumio volumio[1118]: info: ------------------------------ 51ms
Feb 08 00:47:08 volumio volumio[1118]: info:
Feb 08 00:47:08 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:47:08 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:47:08 volumio volumio[1118]: info:
Feb 08 00:47:08 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:08 volumio volumio[1118]: info:
Feb 08 00:47:08 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:47:08 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:47:08 volumio volumio[1118]: info:
Feb 08 00:47:08 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand status took 45 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: ------------------------------ 44ms
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand status took 40 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 39 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 37 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: ------------------------------ 12ms
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand status took 7 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: ------------------------------ 5ms
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:08 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:08 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ceca - Tacno je","artist":"OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:47:08 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:47:08 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:08 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:08 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Ceca - Tacno je","artist":"OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:47:08 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:47:08 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: ------------------------------ 81ms
Feb 08 00:47:08 volumio volumio[1118]: info: ------------------------------ 77ms
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand status took 66 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 61 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 62 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 61 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:08 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:08 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Ceca - Tacno je","artist":"OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:47:08 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:47:08 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:08 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:08 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Ceca - Tacno je","artist":"OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:47:08 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:47:08 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:08 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:08 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Ceca - Tacno je","artist":"OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:47:08 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:47:08 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: ------------------------------ 134ms
Feb 08 00:47:08 volumio volumio[1118]: info: ------------------------------ 131ms
Feb 08 00:47:08 volumio volumio[1118]: info: ------------------------------ 99ms
Feb 08 00:47:08 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 28 milliseconds
Feb 08 00:47:08 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:08 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:08 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:08 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Ceca - Tacno je","artist":"OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:47:08 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:47:08 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:08 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:08 volumio volumio[1118]: info: ------------------------------ 103ms
Feb 08 00:47:12 volumio volumio[1118]: info: CoreCommandRouter::volumioRandom
Feb 08 00:47:12 volumio volumio[1118]: info: CoreCommandRouter::writePlayerControls
Feb 08 00:47:12 volumio volumio[1118]: info: CoreStateMachine::setRandom false
Feb 08 00:47:12 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:12 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:12 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:14 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 08 00:47:16 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 08 00:47:22 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 08 00:47:22 volumio volumio[1118]: info: CoreCommandRouter::volumioStop
Feb 08 00:47:22 volumio volumio[1118]: info: CoreStateMachine::stop
Feb 08 00:47:22 volumio volumio[1118]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 08 00:47:22 volumio volumio[1118]: info: CoreStateMachine::stPlaybackTimer
Feb 08 00:47:22 volumio volumio[1118]: info: CoreStateMachine::updateTrackBlock
Feb 08 00:47:22 volumio volumio[1118]: info: CorePlayQueue::getTrackBlock
Feb 08 00:47:22 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:22 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:22 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:22 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:22 volumio volumio[1118]: info: CoreStateMachine::serviceStop
Feb 08 00:47:22 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:22 volumio volumio[1118]: info: CoreCommandRouter::serviceStop
Feb 08 00:47:22 volumio volumio[1118]: info: [1770508042966] ControllerWebradio::stop
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand stop
Feb 08 00:47:22 volumio volumio[1118]: info:
Feb 08 00:47:22 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:22 volumio volumio[1118]: info: sendMpdCommand stop took 6 milliseconds
Feb 08 00:47:22 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:22 volumio volumio[1118]: info: sendMpdCommand status took 1 milliseconds
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:22 volumio volumio[1118]: info:
Feb 08 00:47:22 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:22 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:22 volumio volumio[1118]: info:
Feb 08 00:47:22 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:47:22 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:47:22 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 08 00:47:22 volumio volumio[1118]: info: sendMpdCommand status took 2 milliseconds
Feb 08 00:47:22 volumio volumio[1118]: info: sendMpdCommand status took 1 milliseconds
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:47:22 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:22 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:22 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:22 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:22 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:22 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:22 volumio volumio[1118]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Feb 08 00:47:22 volumio volumio[1118]: info: ------------------------------ 10ms
Feb 08 00:47:22 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 08 00:47:22 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:22 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:47:22 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:22 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:22 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:22 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:22 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:22 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:22 volumio volumio[1118]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Feb 08 00:47:22 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:47:22 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:47:22 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:22 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:22 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:22 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:22 volumio volumio[1118]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Feb 08 00:47:22 volumio volumio[1118]: info: ------------------------------ 17ms
Feb 08 00:47:22 volumio volumio[1118]: info: ------------------------------ 17ms
Feb 08 00:47:27 volumio volumio[1118]: info: VolumeController::SetAlsaVolume+
Feb 08 00:47:27 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:27 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:27 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:27 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:27 volumio volumio[1118]: info: VolumeController::SetAlsaVolume+
Feb 08 00:47:27 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:27 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:27 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:27 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:27 volumio volumio[1118]: info: VolumeController::SetAlsaVolume+
Feb 08 00:47:27 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:27 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:27 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:27 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:27 volumio volumio[1118]: info: VolumeController::SetAlsaVolume+
Feb 08 00:47:27 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:27 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:27 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:27 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:28 volumio volumio[1118]: info: VolumeController::SetAlsaVolume-
Feb 08 00:47:28 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:28 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:28 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:28 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:28 volumio volumio[1118]: info: VolumeController::SetAlsaVolume-
Feb 08 00:47:28 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:28 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:28 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:28 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:28 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 08 00:47:29 volumio volumio[1118]: info: VolumeController::SetAlsaVolume-
Feb 08 00:47:29 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:29 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:29 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:29 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:29 volumio volumio[1118]: info: VolumeController::SetAlsaVolume-
Feb 08 00:47:29 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:29 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:29 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:29 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:29 volumio volumio[1118]: info: VolumeController::SetAlsaVolume+
Feb 08 00:47:29 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:29 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:29 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:29 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:29 volumio volumio[1118]: info: VolumeController::SetAlsaVolume+
Feb 08 00:47:29 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:47:29 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:47:29 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:47:29 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:47:33 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 08 00:47:43 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 08 00:47:43 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Feb 08 00:47:46 volumio volumio[1118]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 08 00:47:51 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 08 00:47:58 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 08 00:48:36 volumio volumio[1118]: info: CALLMETHOD: system_hardware rotaryencoder2 updateEncoder [object Object]
Feb 08 00:48:36 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: rotaryencoder2 , updateEncoder
Feb 08 00:48:36 volumio sudo[3614]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l
Feb 08 00:48:36 volumio sudo[3614]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 08 00:48:36 volumio sudo[3614]: pam_unix(sudo:session): session closed for user root
Feb 08 00:48:36 volumio sudo[3618]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 1
Feb 08 00:48:36 volumio sudo[3618]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 08 00:48:36 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
Feb 08 00:48:36 volumio sudo[3618]: pam_unix(sudo:session): session closed for user root
Feb 08 00:48:36 volumio sudo[3642]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l
Feb 08 00:48:36 volumio sudo[3642]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 08 00:48:36 volumio sudo[3642]: pam_unix(sudo:session): session closed for user root
Feb 08 00:48:36 volumio sudo[3649]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0
Feb 08 00:48:36 volumio sudo[3649]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 08 00:48:36 volumio sudo[3649]: pam_unix(sudo:session): session closed for user root
Feb 08 00:48:36 volumio sudo[3658]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=2
Feb 08 00:48:36 volumio sudo[3658]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 08 00:48:36 volumio kernel: rotary-encoder rotary@17: gray
Feb 08 00:48:36 volumio kernel: input: rotary@17 as /devices/platform/rotary@17/input/input8
Feb 08 00:48:36 volumio sudo[3658]: pam_unix(sudo:session): session closed for user root
Feb 08 00:48:36 volumio sudo[3668]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=27 active_low=false gpio_pull=up keycode=20
Feb 08 00:48:36 volumio sudo[3668]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 08 00:48:36 volumio kernel: input: button@1b as /devices/platform/button@1b/input/input9
Feb 08 00:48:36 volumio sudo[3668]: pam_unix(sudo:session): session closed for user root
Feb 08 00:48:37 volumio sudo[3679]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l
Feb 08 00:48:37 volumio sudo[3679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 08 00:48:37 volumio sudo[3679]: pam_unix(sudo:session): session closed for user root
Feb 08 00:48:37 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 08 00:48:39 volumio volumio[1118]: info: CoreCommandRouter::volumioPlay
Feb 08 00:48:39 volumio volumio[1118]: info: CoreStateMachine::play index undefined
Feb 08 00:48:39 volumio volumio[1118]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 08 00:48:39 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:48:39 volumio volumio[1118]: info: CoreStateMachine::startPlaybackTimer
Feb 08 00:48:39 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:48:39 volumio volumio[1118]: info: [1770508119604] ControllerWebradio::clearAddPlayTrack
Feb 08 00:48:39 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand stop
Feb 08 00:48:39 volumio volumio[1118]: info: sendMpdCommand stop took 1 milliseconds
Feb 08 00:48:39 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand clear
Feb 08 00:48:39 volumio volumio[1118]: info: sendMpdCommand clear took 1 milliseconds
Feb 08 00:48:39 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99616827"
Feb 08 00:48:39 volumio volumio[1118]: info:
Feb 08 00:48:39 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:48:39 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:48:39 volumio volumio[1118]: info:
Feb 08 00:48:39 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:48:39 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:48:39 volumio volumio[1118]: info:
Feb 08 00:48:39 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:48:39 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:48:39 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
Feb 08 00:48:39 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Feb 08 00:48:39 volumio systemd[1]: setdatetime-helper.service: Consumed 1.600s CPU time.
Feb 08 00:48:39 volumio volumio[1118]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99616827" took 303 milliseconds
Feb 08 00:48:39 volumio volumio[1118]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 08 00:48:39 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand play
Feb 08 00:48:39 volumio volumio[1118]: info:
Feb 08 00:48:39 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:48:39 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:48:39 volumio volumio[1118]: info: ------------------------------ 304ms
Feb 08 00:48:39 volumio volumio[1118]: info: ------------------------------ 304ms
Feb 08 00:48:39 volumio volumio[1118]: info: ------------------------------ 303ms
Feb 08 00:48:39 volumio volumio[1118]: info:
Feb 08 00:48:39 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:48:39 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:48:39 volumio volumio[1118]: info:
Feb 08 00:48:39 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:48:39 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:48:39 volumio volumio[1118]: info: sendMpdCommand play took 6 milliseconds
Feb 08 00:48:39 volumio volumio[1118]: info: ------------------------------ 5ms
Feb 08 00:48:39 volumio volumio[1118]: info: ------------------------------ 2ms
Feb 08 00:48:39 volumio volumio[1118]: info: ------------------------------ 2ms
Feb 08 00:48:40 volumio volumio[1118]: info:
Feb 08 00:48:40 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:48:40 volumio volumio[1118]: info:
Feb 08 00:48:40 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:48:40 volumio volumio[1118]: info:
Feb 08 00:48:40 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:48:40 volumio volumio[1118]: info:
Feb 08 00:48:40 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand status took 6 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand status took 6 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand status took 5 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:48:40 volumio volumio[1118]: info:
Feb 08 00:48:40 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:48:40 volumio volumio[1118]: info:
Feb 08 00:48:40 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand status took 7 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 6 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:48:40 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:48:40 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 1010/8500) OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:48:40 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus stop
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:48:40 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:48:40 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 1010/8500) OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:48:40 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:48:40 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:48:40 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:48:40 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 1010/8500) OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:48:40 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:48:40 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: ------------------------------ 26ms
Feb 08 00:48:40 volumio volumio[1118]: info: ------------------------------ 32ms
Feb 08 00:48:40 volumio volumio[1118]: info: ------------------------------ 31ms
Feb 08 00:48:40 volumio volumio[1118]: info:
Feb 08 00:48:40 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:48:40 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:48:40 volumio volumio[1118]: info:
Feb 08 00:48:40 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand status took 24 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand status took 23 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 19 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:48:40 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:48:40 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Ceca - Tacno je","artist":"OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:48:40 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:48:40 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: ------------------------------ 36ms
Feb 08 00:48:40 volumio volumio[1118]: info:
Feb 08 00:48:40 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:48:40 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:48:40 volumio volumio[1118]: info:
Feb 08 00:48:40 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:48:40 volumio volumio[1118]: info:
Feb 08 00:48:40 volumio volumio[1118]: ---------------------------- MPD announces system playlist update
Feb 08 00:48:40 volumio volumio[1118]: info: Ignoring MPD Status Update
Feb 08 00:48:40 volumio volumio[1118]: info:
Feb 08 00:48:40 volumio volumio[1118]: ---------------------------- MPD announces state update: player
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::getState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand status
Feb 08 00:48:40 volumio volumio[1118]: info: ------------------------------ 22ms
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand status took 22 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 21 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 21 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: ------------------------------ 13ms
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand status took 13 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: ------------------------------ 12ms
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand status took 11 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseState
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:48:40 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:48:40 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Ceca - Tacno je","artist":"OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:48:40 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:48:40 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:48:40 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:48:40 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Ceca - Tacno je","artist":"OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:48:40 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:48:40 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: ------------------------------ 66ms
Feb 08 00:48:40 volumio volumio[1118]: info: ------------------------------ 64ms
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 19 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 19 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: info: sendMpdCommand playlistinfo took 19 milliseconds
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:48:40 volumio volumio[1118]: verbose: ControllerMpd::parseTrackInfo
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:48:40 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:48:40 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Ceca - Tacno je","artist":"OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:48:40 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:48:40 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:48:40 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:48:40 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Ceca - Tacno je","artist":"OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:48:40 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:48:40 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: ControllerMpd::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::servicePushState
Feb 08 00:48:40 volumio volumio[1118]: info: CorePlayQueue::getTrack 0
Feb 08 00:48:40 volumio volumio[1118]: verbose: STATE SERVICE {"status":"play","position":0,"seek":985,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Ceca - Tacno je","artist":"OK Radio 94.2FM","album":null,"uri":"http://sslstream.okradio.net:8000/","trackType":"net:8000/"}
Feb 08 00:48:40 volumio volumio[1118]: verbose: CURRENT POSITION 0
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState stateService play
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::syncState currentStatus play
Feb 08 00:48:40 volumio volumio[1118]: info: Received an update from plugin. extracting info from payload
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreStateMachine::pushState
Feb 08 00:48:40 volumio volumio[1118]: info: CoreCommandRouter::volumioPushState
Feb 08 00:48:40 volumio volumio[1118]: info: ------------------------------ 58ms
Feb 08 00:48:40 volumio volumio[1118]: info: ------------------------------ 49ms
Feb 08 00:48:40 volumio volumio[1118]: info: ------------------------------ 48ms
Feb 08 00:48:41 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 08 00:48:42 volumio volumio[1118]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 08 00:48:42 volumio volumio[1118]: SyntaxError: No number after minus sign in JSON at position 1
Feb 08 00:48:42 volumio volumio[1118]: at JSON.parse ()
Feb 08 00:48:42 volumio volumio[1118]: at rotaryencoder2.emitDialCommand (/data/plugins/system_hardware/rotaryencoder2/index.js:735:73)
Feb 08 00:48:42 volumio volumio[1118]: at Socket. (/data/plugins/system_hardware/rotaryencoder2/index.js:575:11)
Feb 08 00:48:42 volumio volumio[1118]: at Socket.emit (node:events:514:28)
Feb 08 00:48:42 volumio volumio[1118]: at addChunk (node:internal/streams/readable:343:12)
Feb 08 00:48:42 volumio volumio[1118]: at readableAddChunk (node:internal/streams/readable:316:9)
Feb 08 00:48:42 volumio volumio[1118]: at Readable.push (node:internal/streams/readable:253:10)
Feb 08 00:48:42 volumio volumio[1118]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23)
Feb 08 00:48:42 volumio volumio[1118]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 08 00:48:43 volumio sudo[3731]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-08 00:47'
Feb 08 00:48:43 volumio sudo[3731]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025"
VOLUMIO_VERSION="4.084"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"