-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Mon 2025-04-21 23:07:14 CST. --
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 21 23:06:22 volumio volumio[4670]: info: Getting Alsa Cards List without I2S DAC
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Apr 21 23:06:22 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 21 23:06:32 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Apr 21 23:06:32 volumio volumio[4670]: info: Preload queue cleared
Apr 21 23:06:34 volumio volumio[4670]: info: Preload queue cleared
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::ClearQueue
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::stop
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::stPlaybackTimer
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::updateTrackBlock
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::getTrackBlock
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::serviceStop
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::serviceStop
Apr 21 23:06:34 volumio volumio[4670]: info: [1745247994416] ControllerWebradio::stop
Apr 21 23:06:34 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand stop
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::clearPlayQueue
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::saveQueue
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::volumioPushQueue
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::addQueueItems
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::addQueueItems
Apr 21 23:06:34 volumio volumio[4670]: info: Preload queue cleared
Apr 21 23:06:34 volumio volumio[4670]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::volumioPushQueue
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::saveQueue
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::updateTrackBlock
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::getTrackBlock
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::volumioPlay
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::play index 0
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::stop
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::play index undefined
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::startPlaybackTimer
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:34 volumio volumio[4670]: info: [1745247994498] ControllerWebradio::clearAddPlayTrack
Apr 21 23:06:34 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand stop
Apr 21 23:06:34 volumio volumio[4670]: info:
Apr 21 23:06:34 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:34 volumio volumio[4670]: info: sendMpdCommand stop took 123 milliseconds
Apr 21 23:06:34 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:34 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:34 volumio volumio[4670]: info: sendMpdCommand stop took 41 milliseconds
Apr 21 23:06:34 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand clear
Apr 21 23:06:34 volumio volumio[4670]: info:
Apr 21 23:06:34 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:34 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:34 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:34 volumio volumio[4670]: info:
Apr 21 23:06:34 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:34 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:34 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:34 volumio volumio[4670]: info:
Apr 21 23:06:34 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:34 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:34 volumio volumio[4670]: info: sendMpdCommand status took 31 milliseconds
Apr 21 23:06:34 volumio volumio[4670]: info: sendMpdCommand clear took 26 milliseconds
Apr 21 23:06:34 volumio volumio[4670]: info: sendMpdCommand status took 19 milliseconds
Apr 21 23:06:34 volumio volumio[4670]: info: sendMpdCommand status took 15 milliseconds
Apr 21 23:06:34 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:34 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:34 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996"
Apr 21 23:06:34 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:34 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:34 volumio volumio[4670]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 21 23:06:34 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:34 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:34 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:34 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:34 volumio volumio[4670]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 21 23:06:34 volumio volumio[4670]: info: ------------------------------ 90ms
Apr 21 23:06:34 volumio volumio[4670]: info: ------------------------------ 88ms
Apr 21 23:06:34 volumio volumio[4670]: info:
Apr 21 23:06:34 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:34 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:34 volumio volumio[4670]: info:
Apr 21 23:06:34 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:34 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:34 volumio volumio[4670]: error: updateQueue error: null
Apr 21 23:06:34 volumio volumio[4670]: info: ------------------------------ 156ms
Apr 21 23:06:34 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 149 milliseconds
Apr 21 23:06:34 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:34 volumio volumio[4670]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 21 23:06:34 volumio volumio[4670]: info: ------------------------------ 204ms
Apr 21 23:06:34 volumio volumio[4670]: info: touch_display: Setting screensaver timeout to 10 seconds.
Apr 21 23:06:35 volumio volumio[4670]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 709 milliseconds
Apr 21 23:06:35 volumio volumio[4670]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 21 23:06:35 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand play
Apr 21 23:06:35 volumio volumio[4670]: info:
Apr 21 23:06:35 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:35 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:35 volumio volumio[4670]: info: ------------------------------ 648ms
Apr 21 23:06:35 volumio volumio[4670]: info: ------------------------------ 635ms
Apr 21 23:06:35 volumio volumio[4670]: info: sendMpdCommand play took 6 milliseconds
Apr 21 23:06:35 volumio volumio[4670]: info:
Apr 21 23:06:35 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:35 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:35 volumio volumio[4670]: info:
Apr 21 23:06:35 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:35 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:35 volumio volumio[4670]: info: ------------------------------ 12ms
Apr 21 23:06:35 volumio volumio[4670]: info: ------------------------------ 7ms
Apr 21 23:06:35 volumio volumio[4670]: info: ------------------------------ 6ms
Apr 21 23:06:35 volumio volumio[4670]: info: peppy_screensaver: Start PeppyMeter
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:36 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand status took 26 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand status took 27 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand status took 25 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5086/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:36 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus stop
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 41ms
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand status took 15 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 12 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand status took 6 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand status took 4 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5086/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:36 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:36 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5086/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:36 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:36 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 105ms
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 105ms
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 72 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 72 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 72 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5086/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:36 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:36 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5086/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:36 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:36 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5086/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:36 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:36 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 222ms
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 214ms
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 215ms
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:36 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:36 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:36 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:36 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 24ms
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand status took 20 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 19ms
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand status took 17 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 16ms
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:36 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:36 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:36 volumio volumio[4670]: info:
Apr 21 23:06:36 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand status took 39 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 34ms
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand status took 30 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 24 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 25 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 23ms
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand status took 20 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 20ms
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand status took 18 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":817,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Fast Boy x Raf - Wave","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:36 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:36 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:36 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:36 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":817,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Fast Boy x Raf - Wave","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:36 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:36 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:36 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 159ms
Apr 21 23:06:36 volumio volumio[4670]: info: ------------------------------ 156ms
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 110 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 110 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 107 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 107 milliseconds
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:36 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:37 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:37 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:37 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:37 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:37 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":909,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Fast Boy x Raf - Wave","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:37 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:37 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:37 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:37 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:37 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":909,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Fast Boy x Raf - Wave","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:37 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:37 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:37 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:37 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:37 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":909,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Fast Boy x Raf - Wave","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:37 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:37 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:37 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:37 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:37 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":909,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Fast Boy x Raf - Wave","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:37 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:37 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:37 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:37 volumio volumio[4670]: info: ------------------------------ 272ms
Apr 21 23:06:37 volumio volumio[4670]: info: ------------------------------ 268ms
Apr 21 23:06:37 volumio volumio[4670]: info: ------------------------------ 254ms
Apr 21 23:06:37 volumio volumio[4670]: info: ------------------------------ 252ms
Apr 21 23:06:38 volumio volumio[4670]: info:
Apr 21 23:06:38 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:38 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:38 volumio volumio[4670]: info:
Apr 21 23:06:38 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:38 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:38 volumio volumio[4670]: info:
Apr 21 23:06:38 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:38 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:38 volumio volumio[4670]: info:
Apr 21 23:06:38 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:38 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:38 volumio volumio[4670]: info:
Apr 21 23:06:38 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:38 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:38 volumio volumio[4670]: info:
Apr 21 23:06:38 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:38 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:38 volumio volumio[4670]: info: ------------------------------ 15ms
Apr 21 23:06:38 volumio volumio[4670]: info: sendMpdCommand status took 13 milliseconds
Apr 21 23:06:38 volumio volumio[4670]: info: ------------------------------ 12ms
Apr 21 23:06:38 volumio volumio[4670]: info: sendMpdCommand status took 11 milliseconds
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:38 volumio volumio[4670]: info: ------------------------------ 15ms
Apr 21 23:06:38 volumio volumio[4670]: info: sendMpdCommand status took 14 milliseconds
Apr 21 23:06:38 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 21 23:06:38 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:38 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:38 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:38 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2212,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Fast Boy x Raf - Wave","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:38 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:38 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:38 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:38 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:38 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2212,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Fast Boy x Raf - Wave","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:38 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:38 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:38 volumio volumio[4670]: info: ------------------------------ 73ms
Apr 21 23:06:38 volumio volumio[4670]: info: ------------------------------ 72ms
Apr 21 23:06:38 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 56 milliseconds
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:38 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:38 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:38 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2212,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Fast Boy x Raf - Wave","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:38 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:38 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:38 volumio volumio[4670]: info: ------------------------------ 111ms
Apr 21 23:06:38 volumio volumio[4670]: info:
Apr 21 23:06:38 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:38 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:38 volumio volumio[4670]: info:
Apr 21 23:06:38 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:38 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:38 volumio volumio[4670]: info:
Apr 21 23:06:38 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:38 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:38 volumio volumio[4670]: info:
Apr 21 23:06:38 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:38 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:38 volumio volumio[4670]: info:
Apr 21 23:06:38 volumio volumio[4670]: ---------------------------- MPD announces system playlist update
Apr 21 23:06:38 volumio volumio[4670]: info: Ignoring MPD Status Update
Apr 21 23:06:38 volumio volumio[4670]: info:
Apr 21 23:06:38 volumio volumio[4670]: ---------------------------- MPD announces state update: player
Apr 21 23:06:38 volumio volumio[4670]: info: ControllerMpd::getState
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand status
Apr 21 23:06:38 volumio volumio[4670]: info: ------------------------------ 14ms
Apr 21 23:06:38 volumio volumio[4670]: info: sendMpdCommand status took 12 milliseconds
Apr 21 23:06:38 volumio volumio[4670]: info: ------------------------------ 11ms
Apr 21 23:06:38 volumio volumio[4670]: info: sendMpdCommand status took 9 milliseconds
Apr 21 23:06:38 volumio volumio[4670]: info: ------------------------------ 9ms
Apr 21 23:06:38 volumio volumio[4670]: info: sendMpdCommand status took 7 milliseconds
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::parseState
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 21 23:06:38 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 21 23:06:38 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 21 23:06:38 volumio volumio[4670]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:38 volumio volumio[4670]: verbose: ControllerMpd::parseTrackInfo
Apr 21 23:06:38 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:38 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:38 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Fast Boy x Raf - Wave","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:38 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:38 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:38 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:38 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:38 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Fast Boy x Raf - Wave","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:38 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:38 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:38 volumio volumio[4670]: info: ControllerMpd::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::servicePushState
Apr 21 23:06:38 volumio volumio[4670]: info: CorePlayQueue::getTrack 0
Apr 21 23:06:38 volumio volumio[4670]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Fast Boy x Raf - Wave","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Apr 21 23:06:38 volumio volumio[4670]: verbose: CURRENT POSITION 0
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::syncState stateService play
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::syncState currentStatus play
Apr 21 23:06:38 volumio volumio[4670]: info: Received an update from plugin. extracting info from payload
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreStateMachine::pushState
Apr 21 23:06:38 volumio volumio[4670]: info: CoreCommandRouter::volumioPushState
Apr 21 23:06:38 volumio volumio[4670]: info: ------------------------------ 93ms
Apr 21 23:06:38 volumio volumio[4670]: info: ------------------------------ 92ms
Apr 21 23:06:38 volumio volumio[4670]: info: ------------------------------ 90ms
Apr 21 23:06:49 volumio volumio[4670]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Apr 21 23:06:49 volumio volumio[4670]: info: CoreCommandRouter::volumioGetState
Apr 21 23:06:52 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 21 23:06:52 volumio volumio[4670]: info: CURURI: playlists
Apr 21 23:06:52 volumio volumio[4670]: info: Listing playlists
Apr 21 23:06:52 volumio volumio[4670]: info: Preload queue cleared
Apr 21 23:06:53 volumio volumio[4670]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9
Apr 21 23:06:53 volumio volumio[4670]: info: CoreCommandRouter::volumioGetState
Apr 21 23:07:10 volumio volumio[4670]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 21 23:07:10 volumio volumio[4670]: info: CURURI: albums://
Apr 21 23:07:10 volumio volumio[4670]: info: listAlbums - loading Albums from cache
Apr 21 23:07:10 volumio volumio[4670]: info: Preload queue cleared
Apr 21 23:07:12 volumio volumio[4670]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 23:07:13 volumio volumio[4670]: Error: connect ECONNREFUSED 4.78.139.50:80
Apr 21 23:07:13 volumio volumio[4670]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Apr 21 23:07:13 volumio volumio[4670]: errno: -111,
Apr 21 23:07:13 volumio volumio[4670]: code: 'ECONNREFUSED',
Apr 21 23:07:13 volumio volumio[4670]: syscall: 'connect',
Apr 21 23:07:13 volumio volumio[4670]: address: '4.78.139.50',
Apr 21 23:07:13 volumio volumio[4670]: port: 80
Apr 21 23:07:13 volumio volumio[4670]: }
Apr 21 23:07:13 volumio volumio[4670]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 21 23:07:14 volumio sudo[6911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-21 23:06
Apr 21 23:07:14 volumio sudo[6911]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST"
VOLUMIO_VERSION="3.757"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"