-- Logs begin at Tue 2024-09-03 23:59:04 CST, end at Wed 2024-09-04 00:14:17 CST. --
Sep 04 00:13:05 volumio volumio[859]: info: MyVolumio login type: Token
Sep 04 00:13:11 volumio volumio[859]: info: Preload queue cleared
Sep 04 00:13:11 volumio volumio[859]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 04 00:13:11 volumio volumio[859]: info: CoreStateMachine::ClearQueue
Sep 04 00:13:11 volumio volumio[859]: info: CoreStateMachine::stop
Sep 04 00:13:11 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 00:13:11 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer
Sep 04 00:13:11 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock
Sep 04 00:13:11 volumio volumio[859]: info: CorePlayQueue::getTrackBlock
Sep 04 00:13:11 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:11 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:11 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:11 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:12 volumio volumio[859]: info: CoreStateMachine::serviceStop
Sep 04 00:13:12 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:12 volumio volumio[859]: info: CoreCommandRouter::serviceStop
Sep 04 00:13:12 volumio volumio[859]: info: [1725379992250] ControllerWebradio::stop
Sep 04 00:13:12 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Sep 04 00:13:12 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue
Sep 04 00:13:12 volumio volumio[859]: info: CorePlayQueue::saveQueue
Sep 04 00:13:12 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue
Sep 04 00:13:12 volumio volumio[859]: info: CoreStateMachine::addQueueItems
Sep 04 00:13:12 volumio volumio[859]: info: CorePlayQueue::addQueueItems
Sep 04 00:13:12 volumio volumio[859]: info: Preload queue cleared
Sep 04 00:13:12 volumio volumio[859]: info: Adding Item to queue: http://stream.srg-ssr.ch/m/rsj/aacp_96
Sep 04 00:13:12 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Sep 04 00:13:12 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue
Sep 04 00:13:12 volumio volumio[859]: info: CorePlayQueue::saveQueue
Sep 04 00:13:12 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock
Sep 04 00:13:12 volumio volumio[859]: info: CorePlayQueue::getTrackBlock
Sep 04 00:13:12 volumio volumio[859]: info: CoreCommandRouter::volumioPlay
Sep 04 00:13:12 volumio volumio[859]: info: CoreStateMachine::play index 0
Sep 04 00:13:12 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 00:13:12 volumio volumio[859]: info: CoreStateMachine::stop
Sep 04 00:13:12 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 00:13:12 volumio volumio[859]: info: CoreStateMachine::play index undefined
Sep 04 00:13:12 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 00:13:12 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:12 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer
Sep 04 00:13:12 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:12 volumio volumio[859]: info: [1725379992792] ControllerWebradio::clearAddPlayTrack
Sep 04 00:13:12 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Sep 04 00:13:12 volumio volumio[859]: info:
Sep 04 00:13:12 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:12 volumio volumio[859]: info: sendMpdCommand stop took 640 milliseconds
Sep 04 00:13:12 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:12 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:12 volumio volumio[859]: info: sendMpdCommand stop took 106 milliseconds
Sep 04 00:13:12 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear
Sep 04 00:13:12 volumio volumio[859]: info:
Sep 04 00:13:12 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:12 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:12 volumio volumio[859]: info: sendMpdCommand status took 37 milliseconds
Sep 04 00:13:12 volumio volumio[859]: info: sendMpdCommand clear took 24 milliseconds
Sep 04 00:13:12 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:12 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:12 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand load "http://stream.srg-ssr.ch/m/rsj/aacp_96"
Sep 04 00:13:13 volumio volumio[859]: error: updateQueue error: null
Sep 04 00:13:13 volumio volumio[859]: info: ------------------------------ 110ms
Sep 04 00:13:13 volumio volumio[859]: info: sendMpdCommand playlistinfo took 91 milliseconds
Sep 04 00:13:13 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:13 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Sep 04 00:13:13 volumio volumio[859]: info: ------------------------------ 175ms
Sep 04 00:13:13 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand add "http://stream.srg-ssr.ch/m/rsj/aacp_96"
Sep 04 00:13:13 volumio volumio[859]: info:
Sep 04 00:13:13 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:13 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:13 volumio volumio[859]: info: sendMpdCommand add "http://stream.srg-ssr.ch/m/rsj/aacp_96" took 15 milliseconds
Sep 04 00:13:13 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd
Sep 04 00:13:13 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play
Sep 04 00:13:13 volumio volumio[859]: info: ------------------------------ 46ms
Sep 04 00:13:13 volumio volumio[859]: info: sendMpdCommand play took 29 milliseconds
Sep 04 00:13:16 volumio volumio[859]: info:
Sep 04 00:13:16 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:16 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:16 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:16 volumio volumio[859]: info:
Sep 04 00:13:16 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:16 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:16 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:16 volumio volumio[859]: info: sendMpdCommand status took 55 milliseconds
Sep 04 00:13:16 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:16 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:16 volumio volumio[859]: info: sendMpdCommand status took 45 milliseconds
Sep 04 00:13:16 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:16 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:16 volumio volumio[859]: info: sendMpdCommand playlistinfo took 42 milliseconds
Sep 04 00:13:16 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:16 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:16 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:16 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:16 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"aacp_96","artist":null,"album":null,"uri":"http://stream.srg-ssr.ch/m/rsj/aacp_96","trackType":""}
Sep 04 00:13:16 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:16 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:16 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop
Sep 04 00:13:16 volumio volumio[859]: info: ------------------------------ 191ms
Sep 04 00:13:16 volumio volumio[859]: info: sendMpdCommand playlistinfo took 80 milliseconds
Sep 04 00:13:16 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:16 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:16 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:16 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:16 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"aacp_96","artist":null,"album":null,"uri":"http://stream.srg-ssr.ch/m/rsj/aacp_96","trackType":""}
Sep 04 00:13:16 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:16 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:16 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:13:16 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:13:16 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:16 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:16 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:16 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:16 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:16 volumio volumio[859]: info: ------------------------------ 677ms
Sep 04 00:13:16 volumio volumio[859]: info:
Sep 04 00:13:16 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:16 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:16 volumio volumio[859]: info:
Sep 04 00:13:16 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:16 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:16 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:17 volumio volumio[859]: info: ------------------------------ 213ms
Sep 04 00:13:17 volumio volumio[859]: info: sendMpdCommand status took 198 milliseconds
Sep 04 00:13:17 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:17 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:17 volumio volumio[859]: info: sendMpdCommand playlistinfo took 63 milliseconds
Sep 04 00:13:17 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:17 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:17 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:17 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:17 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1113,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"94 Kbps","isStreaming":false,"title":"Nolan Quinn - Flibbertigibbet Blues","artist":"/SwissJazz_Room2.aac","album":null,"uri":"http://stream.srg-ssr.ch/m/rsj/aacp_96","trackType":""}
Sep 04 00:13:17 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:17 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:17 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:13:17 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:13:17 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:17 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:17 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:17 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:17 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:17 volumio volumio[859]: info: ------------------------------ 761ms
Sep 04 00:13:28 volumio volumio[859]: info: Preload queue cleared
Sep 04 00:13:28 volumio volumio[859]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 04 00:13:28 volumio volumio[859]: info: CoreStateMachine::ClearQueue
Sep 04 00:13:28 volumio volumio[859]: info: CoreStateMachine::stop
Sep 04 00:13:28 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 00:13:28 volumio volumio[859]: info: CoreStateMachine::stPlaybackTimer
Sep 04 00:13:28 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock
Sep 04 00:13:28 volumio volumio[859]: info: CorePlayQueue::getTrackBlock
Sep 04 00:13:28 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:28 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:29 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:29 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:29 volumio volumio[859]: info: CoreStateMachine::serviceStop
Sep 04 00:13:29 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:29 volumio volumio[859]: info: CoreCommandRouter::serviceStop
Sep 04 00:13:29 volumio volumio[859]: info: [1725380009136] ControllerWebradio::stop
Sep 04 00:13:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Sep 04 00:13:29 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue
Sep 04 00:13:29 volumio volumio[859]: info: CorePlayQueue::saveQueue
Sep 04 00:13:29 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue
Sep 04 00:13:29 volumio volumio[859]: info: CoreStateMachine::addQueueItems
Sep 04 00:13:29 volumio volumio[859]: info: CorePlayQueue::addQueueItems
Sep 04 00:13:29 volumio volumio[859]: info: Preload queue cleared
Sep 04 00:13:29 volumio volumio[859]: info: Adding Item to queue: http://119.15.96.188/stream2.mp3
Sep 04 00:13:29 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Sep 04 00:13:29 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue
Sep 04 00:13:29 volumio volumio[859]: info: CorePlayQueue::saveQueue
Sep 04 00:13:29 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock
Sep 04 00:13:29 volumio volumio[859]: info: CorePlayQueue::getTrackBlock
Sep 04 00:13:29 volumio volumio[859]: info: CoreCommandRouter::volumioPlay
Sep 04 00:13:29 volumio volumio[859]: info: CoreStateMachine::play index 0
Sep 04 00:13:29 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 00:13:29 volumio volumio[859]: info: CoreStateMachine::stop
Sep 04 00:13:29 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 00:13:29 volumio volumio[859]: info: CoreStateMachine::play index undefined
Sep 04 00:13:29 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 00:13:29 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:29 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer
Sep 04 00:13:29 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:29 volumio volumio[859]: info: [1725380009453] ControllerWebradio::clearAddPlayTrack
Sep 04 00:13:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Sep 04 00:13:29 volumio volumio[859]: info:
Sep 04 00:13:29 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:29 volumio volumio[859]: info: sendMpdCommand stop took 385 milliseconds
Sep 04 00:13:29 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:29 volumio volumio[859]: info: sendMpdCommand stop took 79 milliseconds
Sep 04 00:13:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear
Sep 04 00:13:29 volumio volumio[859]: info:
Sep 04 00:13:29 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:29 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:29 volumio volumio[859]: info: sendMpdCommand status took 36 milliseconds
Sep 04 00:13:29 volumio volumio[859]: info: sendMpdCommand clear took 27 milliseconds
Sep 04 00:13:29 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:29 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand load "http://119.15.96.188/stream2.mp3"
Sep 04 00:13:29 volumio volumio[859]: error: updateQueue error: null
Sep 04 00:13:29 volumio volumio[859]: info: ------------------------------ 148ms
Sep 04 00:13:29 volumio volumio[859]: info: sendMpdCommand playlistinfo took 129 milliseconds
Sep 04 00:13:29 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:29 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Sep 04 00:13:29 volumio volumio[859]: info: ------------------------------ 213ms
Sep 04 00:13:35 volumio volumio[859]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Sep 04 00:13:35 volumio volumio[859]: info: Retrying Login Due to Network Error
Sep 04 00:13:39 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand add "http://119.15.96.188/stream2.mp3"
Sep 04 00:13:39 volumio volumio[859]: Upnp client error: Error: This socket has been ended by the other party
Sep 04 00:13:39 volumio volumio[859]: Upnp client error: Error: This socket has been ended by the other party
Sep 04 00:13:39 volumio volumio[859]: Upnp client error: Error: This socket has been ended by the other party
Sep 04 00:13:39 volumio volumio[859]: Upnp client error: Error: This socket has been ended by the other party
Sep 04 00:13:39 volumio volumio[859]: info:
Sep 04 00:13:39 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:39 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:39 volumio volumio[859]: info: sendMpdCommand add "http://119.15.96.188/stream2.mp3" took 29 milliseconds
Sep 04 00:13:39 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd
Sep 04 00:13:39 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play
Sep 04 00:13:39 volumio volumio[859]: info: ------------------------------ 29ms
Sep 04 00:13:39 volumio volumio[859]: info: sendMpdCommand play took 15 milliseconds
Sep 04 00:13:40 volumio volumio[859]: info: Preload queue cleared
Sep 04 00:13:41 volumio volumio[859]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 04 00:13:41 volumio volumio[859]: info: CoreStateMachine::ClearQueue
Sep 04 00:13:41 volumio volumio[859]: info: CoreStateMachine::stop
Sep 04 00:13:41 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 00:13:41 volumio volumio[859]: info: CorePlayQueue::clearPlayQueue
Sep 04 00:13:41 volumio volumio[859]: info: CorePlayQueue::saveQueue
Sep 04 00:13:41 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue
Sep 04 00:13:41 volumio volumio[859]: info: CoreStateMachine::addQueueItems
Sep 04 00:13:41 volumio volumio[859]: info: CorePlayQueue::addQueueItems
Sep 04 00:13:41 volumio volumio[859]: info: Preload queue cleared
Sep 04 00:13:41 volumio volumio[859]: info: Adding Item to queue: http://vis.media-ice.musicradio.com/ClassicFMMP3
Sep 04 00:13:41 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Sep 04 00:13:41 volumio volumio[859]: info: CoreCommandRouter::volumioPushQueue
Sep 04 00:13:41 volumio volumio[859]: info: CorePlayQueue::saveQueue
Sep 04 00:13:41 volumio volumio[859]: info: CoreStateMachine::updateTrackBlock
Sep 04 00:13:41 volumio volumio[859]: info: CorePlayQueue::getTrackBlock
Sep 04 00:13:41 volumio volumio[859]: info: CoreCommandRouter::volumioPlay
Sep 04 00:13:41 volumio volumio[859]: info: CoreStateMachine::play index 0
Sep 04 00:13:41 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 00:13:41 volumio volumio[859]: info: CoreStateMachine::stop
Sep 04 00:13:41 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 00:13:41 volumio volumio[859]: info: CoreStateMachine::play index undefined
Sep 04 00:13:41 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 04 00:13:41 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:41 volumio volumio[859]: info: CoreStateMachine::startPlaybackTimer
Sep 04 00:13:41 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:41 volumio volumio[859]: info: [1725380021256] ControllerWebradio::clearAddPlayTrack
Sep 04 00:13:41 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand stop
Sep 04 00:13:41 volumio volumio[859]: info:
Sep 04 00:13:41 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:41 volumio volumio[859]: info: sendMpdCommand stop took 43 milliseconds
Sep 04 00:13:41 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:41 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:41 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand clear
Sep 04 00:13:41 volumio volumio[859]: info:
Sep 04 00:13:41 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:41 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:41 volumio volumio[859]: info: sendMpdCommand status took 26 milliseconds
Sep 04 00:13:41 volumio volumio[859]: info: sendMpdCommand clear took 25 milliseconds
Sep 04 00:13:41 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:41 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:41 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand load "http://vis.media-ice.musicradio.com/ClassicFMMP3"
Sep 04 00:13:41 volumio volumio[859]: error: updateQueue error: null
Sep 04 00:13:41 volumio volumio[859]: info: ------------------------------ 49ms
Sep 04 00:13:41 volumio volumio[859]: info: sendMpdCommand playlistinfo took 31 milliseconds
Sep 04 00:13:41 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:41 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Sep 04 00:13:41 volumio volumio[859]: info: ------------------------------ 96ms
Sep 04 00:13:42 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand add "http://vis.media-ice.musicradio.com/ClassicFMMP3"
Sep 04 00:13:42 volumio volumio[859]: info:
Sep 04 00:13:42 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:42 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:42 volumio volumio[859]: info: sendMpdCommand add "http://vis.media-ice.musicradio.com/ClassicFMMP3" took 15 milliseconds
Sep 04 00:13:42 volumio volumio[859]: info: CoreStateMachine::setConsumeUpdateService mpd
Sep 04 00:13:42 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand play
Sep 04 00:13:42 volumio volumio[859]: info: ------------------------------ 32ms
Sep 04 00:13:42 volumio volumio[859]: info: sendMpdCommand play took 17 milliseconds
Sep 04 00:13:42 volumio volumio[859]: info:
Sep 04 00:13:42 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:42 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:42 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:42 volumio volumio[859]: info: sendMpdCommand status took 14 milliseconds
Sep 04 00:13:42 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:42 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:42 volumio volumio[859]: info: sendMpdCommand playlistinfo took 13 milliseconds
Sep 04 00:13:42 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:42 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:42 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:42 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:42 volumio volumio[859]: 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":"ClassicFMMP3","artist":null,"album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:13:42 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:42 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:42 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop
Sep 04 00:13:42 volumio volumio[859]: info: ------------------------------ 102ms
Sep 04 00:13:42 volumio volumio[859]: info:
Sep 04 00:13:42 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:42 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:42 volumio volumio[859]: info:
Sep 04 00:13:42 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:42 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:42 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:42 volumio volumio[859]: info: ------------------------------ 41ms
Sep 04 00:13:42 volumio volumio[859]: info: sendMpdCommand status took 24 milliseconds
Sep 04 00:13:42 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:42 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:42 volumio volumio[859]: info:
Sep 04 00:13:42 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:42 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:42 volumio volumio[859]: info:
Sep 04 00:13:42 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:43 volumio volumio[859]: info: sendMpdCommand playlistinfo took 30 milliseconds
Sep 04 00:13:43 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:43 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:43 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:43 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:43 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:43 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:43 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":388,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:13:43 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:43 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:43 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:13:43 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:13:43 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:43 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:43 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:43 volumio volumio[859]: info: ------------------------------ 735ms
Sep 04 00:13:43 volumio volumio[859]: info: ------------------------------ 673ms
Sep 04 00:13:43 volumio volumio[859]: info: sendMpdCommand status took 644 milliseconds
Sep 04 00:13:43 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:43 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:43 volumio volumio[859]: info:
Sep 04 00:13:43 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:43 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:43 volumio volumio[859]: info: sendMpdCommand playlistinfo took 152 milliseconds
Sep 04 00:13:43 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:43 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:43 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:43 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:43 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":883,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:13:43 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:43 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:43 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:13:43 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:13:43 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:43 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:44 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:44 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:44 volumio volumio[859]: info: ------------------------------ 1179ms
Sep 04 00:13:44 volumio volumio[859]: info:
Sep 04 00:13:44 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:44 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:44 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:44 volumio volumio[859]: info: ------------------------------ 421ms
Sep 04 00:13:44 volumio volumio[859]: info: sendMpdCommand status took 117 milliseconds
Sep 04 00:13:44 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:44 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:44 volumio volumio[859]: info: sendMpdCommand playlistinfo took 11 milliseconds
Sep 04 00:13:44 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:44 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:44 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:44 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:44 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2186,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:13:44 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:44 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:44 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:13:44 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:13:44 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:44 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:44 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:44 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:44 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:44 volumio volumio[859]: info: ------------------------------ 439ms
Sep 04 00:13:45 volumio volumio[859]: info: MyVolumio login type: Token
Sep 04 00:13:46 volumio volumio[859]: info:
Sep 04 00:13:46 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:46 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:46 volumio volumio[859]: info:
Sep 04 00:13:46 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:46 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:46 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:46 volumio volumio[859]: info: ------------------------------ 30ms
Sep 04 00:13:46 volumio volumio[859]: info: sendMpdCommand status took 16 milliseconds
Sep 04 00:13:46 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:46 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:46 volumio volumio[859]: info: sendMpdCommand playlistinfo took 10 milliseconds
Sep 04 00:13:46 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:46 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:46 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:46 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:46 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4581,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:13:46 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:46 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:46 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:13:46 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:13:46 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:46 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:46 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:46 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:46 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:46 volumio volumio[859]: info: ------------------------------ 289ms
Sep 04 00:13:48 volumio volumio[859]: info:
Sep 04 00:13:48 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:48 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:48 volumio volumio[859]: info:
Sep 04 00:13:48 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:48 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:48 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:48 volumio volumio[859]: info: ------------------------------ 32ms
Sep 04 00:13:48 volumio volumio[859]: info: sendMpdCommand status took 16 milliseconds
Sep 04 00:13:48 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:48 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:48 volumio volumio[859]: info: sendMpdCommand playlistinfo took 9 milliseconds
Sep 04 00:13:48 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:48 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:48 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:48 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:48 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":6783,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:13:48 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:48 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:48 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:13:48 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:13:48 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:48 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:49 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:49 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:49 volumio volumio[859]: info: ------------------------------ 467ms
Sep 04 00:13:51 volumio volumio[859]: info:
Sep 04 00:13:51 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:51 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:51 volumio volumio[859]: info:
Sep 04 00:13:51 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:51 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:51 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:51 volumio volumio[859]: info: ------------------------------ 34ms
Sep 04 00:13:51 volumio volumio[859]: info: sendMpdCommand status took 23 milliseconds
Sep 04 00:13:51 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:51 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:51 volumio volumio[859]: info: sendMpdCommand playlistinfo took 9 milliseconds
Sep 04 00:13:51 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:51 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:51 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:51 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:51 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9683,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:13:51 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:51 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:51 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:13:51 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:13:51 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:51 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:51 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:51 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:51 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:52 volumio volumio[859]: info: ------------------------------ 299ms
Sep 04 00:13:54 volumio volumio[859]: info:
Sep 04 00:13:54 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:54 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:54 volumio volumio[859]: info:
Sep 04 00:13:54 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:54 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:54 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:54 volumio volumio[859]: info: ------------------------------ 50ms
Sep 04 00:13:54 volumio volumio[859]: info: sendMpdCommand status took 9 milliseconds
Sep 04 00:13:54 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:54 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:54 volumio volumio[859]: info: sendMpdCommand playlistinfo took 11 milliseconds
Sep 04 00:13:54 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:54 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:54 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:54 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:54 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11988,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:13:54 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:54 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:54 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:13:54 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:13:54 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:54 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:54 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:54 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:54 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:54 volumio volumio[859]: info: ------------------------------ 333ms
Sep 04 00:13:55 volumio sudo[1814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 04 00:13:55 volumio sudo[1816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 04 00:13:55 volumio sudo[1814]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 04 00:13:55 volumio sudo[1816]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 04 00:13:56 volumio sudo[1814]: pam_unix(sudo:session): session closed for user root
Sep 04 00:13:56 volumio sudo[1816]: pam_unix(sudo:session): session closed for user root
Sep 04 00:13:56 volumio volumio[859]: verbose: New Socket.io Connection to 192.168.1.29 from 192.168.1.14 UA: okhttp/4.9.2 Total Clients: 6
Sep 04 00:13:56 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 04 00:13:56 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 04 00:13:56 volumio volumio[859]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 04 00:13:56 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 04 00:13:56 volumio volumio[859]: info: CoreCommandRouter::volumioGetState
Sep 04 00:13:56 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 04 00:13:56 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 04 00:13:56 volumio volumio[859]: info: Received Get System Info
Sep 04 00:13:56 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 04 00:13:56 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 04 00:13:56 volumio volumio[859]: info: Discovery: Getting this device information
Sep 04 00:13:56 volumio volumio[859]: info: CoreCommandRouter::volumioGetState
Sep 04 00:13:56 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 04 00:13:56 volumio volumio[859]: info: CoreCommandRouter::volumioGetState
Sep 04 00:13:57 volumio volumio[859]: info: Listing playlists
Sep 04 00:13:57 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue
Sep 04 00:13:57 volumio volumio[859]: info: CoreStateMachine::getQueue
Sep 04 00:13:57 volumio volumio[859]: info: CorePlayQueue::getQueue
Sep 04 00:13:57 volumio volumio[859]: info: Received Get System Info
Sep 04 00:13:57 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 04 00:13:57 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 04 00:13:57 volumio volumio[859]: info: Discovery: Getting this device information
Sep 04 00:13:57 volumio volumio[859]: info: CoreCommandRouter::volumioGetState
Sep 04 00:13:57 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 04 00:13:57 volumio volumio[859]: info: CoreCommandRouter::volumioGetState
Sep 04 00:13:57 volumio volumio[859]: info:
Sep 04 00:13:57 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:57 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:57 volumio volumio[859]: info:
Sep 04 00:13:57 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:57 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:57 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:57 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Sep 04 00:13:57 volumio volumio[859]: info: ------------------------------ 172ms
Sep 04 00:13:57 volumio volumio[859]: info: sendMpdCommand status took 156 milliseconds
Sep 04 00:13:57 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:57 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:58 volumio volumio[859]: info: sendMpdCommand playlistinfo took 641 milliseconds
Sep 04 00:13:58 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:58 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:58 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:58 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:58 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15684,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:13:58 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:58 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:58 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:13:58 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:13:58 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:58 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:58 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:58 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:58 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:58 volumio volumio[859]: info: ------------------------------ 1027ms
Sep 04 00:13:58 volumio volumio[859]: info:
Sep 04 00:13:58 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:13:58 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:13:58 volumio volumio[859]: info:
Sep 04 00:13:58 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:13:58 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:13:58 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:13:59 volumio volumio[859]: info: ------------------------------ 109ms
Sep 04 00:13:59 volumio volumio[859]: info: sendMpdCommand status took 77 milliseconds
Sep 04 00:13:59 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:13:59 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:13:59 volumio volumio[859]: info: sendMpdCommand playlistinfo took 31 milliseconds
Sep 04 00:13:59 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:13:59 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:13:59 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:13:59 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:13:59 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":16884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:13:59 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:13:59 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:13:59 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:13:59 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:13:59 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:59 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:13:59 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:59 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:13:59 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:13:59 volumio volumio[859]: info: ------------------------------ 484ms
Sep 04 00:14:01 volumio volumio[859]: info:
Sep 04 00:14:01 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:14:01 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:14:01 volumio volumio[859]: info:
Sep 04 00:14:01 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:14:01 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:14:01 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:14:01 volumio volumio[859]: info: ------------------------------ 31ms
Sep 04 00:14:01 volumio volumio[859]: info: sendMpdCommand status took 19 milliseconds
Sep 04 00:14:01 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:14:01 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:14:01 volumio volumio[859]: info: sendMpdCommand playlistinfo took 8 milliseconds
Sep 04 00:14:01 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:14:01 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:14:01 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:14:01 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:14:01 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":19278,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:14:01 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:14:01 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:14:01 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:14:01 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:14:01 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:14:01 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:14:01 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:14:01 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:14:01 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:14:01 volumio volumio[859]: info: ------------------------------ 341ms
Sep 04 00:14:04 volumio volumio[859]: info:
Sep 04 00:14:04 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:14:04 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:14:04 volumio volumio[859]: info:
Sep 04 00:14:04 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:14:04 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:14:04 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:14:04 volumio volumio[859]: info: ------------------------------ 42ms
Sep 04 00:14:04 volumio volumio[859]: info: sendMpdCommand status took 18 milliseconds
Sep 04 00:14:04 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:14:04 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:14:04 volumio volumio[859]: info: sendMpdCommand playlistinfo took 11 milliseconds
Sep 04 00:14:04 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:14:04 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:14:04 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:14:04 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:14:04 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22177,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:14:04 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:14:04 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:14:04 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:14:04 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:14:04 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:14:04 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:14:04 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:14:04 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:14:04 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:14:04 volumio volumio[859]: info: ------------------------------ 497ms
Sep 04 00:14:06 volumio volumio[859]: info:
Sep 04 00:14:06 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:14:06 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:14:06 volumio volumio[859]: info:
Sep 04 00:14:06 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:14:06 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:14:06 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:14:06 volumio volumio[859]: info: ------------------------------ 64ms
Sep 04 00:14:06 volumio volumio[859]: info: sendMpdCommand status took 46 milliseconds
Sep 04 00:14:06 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:14:06 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:14:06 volumio volumio[859]: info: sendMpdCommand playlistinfo took 10 milliseconds
Sep 04 00:14:06 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:14:06 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:14:06 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:14:06 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:14:06 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":24483,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:14:06 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:14:06 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:14:06 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:14:06 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:14:06 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:14:06 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:14:06 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:14:06 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:14:06 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:14:06 volumio volumio[859]: info: ------------------------------ 368ms
Sep 04 00:14:09 volumio volumio[859]: info:
Sep 04 00:14:09 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:14:09 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:14:09 volumio volumio[859]: info:
Sep 04 00:14:09 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:14:09 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:14:09 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:14:09 volumio volumio[859]: info: ------------------------------ 39ms
Sep 04 00:14:09 volumio volumio[859]: info: sendMpdCommand status took 28 milliseconds
Sep 04 00:14:09 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:14:09 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:14:09 volumio volumio[859]: info: sendMpdCommand playlistinfo took 5 milliseconds
Sep 04 00:14:09 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:14:09 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:14:09 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:14:09 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:14:09 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":27279,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:14:09 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:14:09 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:14:09 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:14:09 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:14:09 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:14:09 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:14:09 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:14:09 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:14:09 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:14:09 volumio volumio[859]: info: ------------------------------ 438ms
Sep 04 00:14:11 volumio volumio[859]: info:
Sep 04 00:14:11 volumio volumio[859]: ---------------------------- MPD announces system playlist update
Sep 04 00:14:11 volumio volumio[859]: info: Ignoring MPD Status Update
Sep 04 00:14:11 volumio volumio[859]: info:
Sep 04 00:14:11 volumio volumio[859]: ---------------------------- MPD announces state update: player
Sep 04 00:14:11 volumio volumio[859]: info: ControllerMpd::getState
Sep 04 00:14:11 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status
Sep 04 00:14:11 volumio volumio[859]: info: ------------------------------ 101ms
Sep 04 00:14:11 volumio volumio[859]: info: sendMpdCommand status took 55 milliseconds
Sep 04 00:14:11 volumio volumio[859]: verbose: ControllerMpd::parseState
Sep 04 00:14:11 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 04 00:14:11 volumio volumio[859]: info: sendMpdCommand playlistinfo took 18 milliseconds
Sep 04 00:14:11 volumio volumio[859]: verbose: ControllerMpd::parseTrackInfo
Sep 04 00:14:11 volumio volumio[859]: info: ControllerMpd::pushState
Sep 04 00:14:11 volumio volumio[859]: info: CoreCommandRouter::servicePushState
Sep 04 00:14:11 volumio volumio[859]: info: CorePlayQueue::getTrack 0
Sep 04 00:14:11 volumio volumio[859]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29585,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Enya, 2Cellos - May It Be","artist":"Classic FM","album":null,"uri":"http://vis.media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Sep 04 00:14:11 volumio volumio[859]: verbose: CURRENT POSITION 0
Sep 04 00:14:11 volumio volumio[859]: info: CoreStateMachine::syncState stateService play
Sep 04 00:14:11 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus play
Sep 04 00:14:11 volumio volumio[859]: info: Received an update from plugin. extracting info from payload
Sep 04 00:14:11 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:14:11 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 04 00:14:11 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:14:12 volumio volumio[859]: info: CoreStateMachine::pushState
Sep 04 00:14:12 volumio volumio[859]: info: CoreCommandRouter::volumioPushState
Sep 04 00:14:12 volumio volumio[859]: info: ------------------------------ 561ms
Sep 04 00:14:13 volumio volumio[859]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 04 00:14:13 volumio volumio[859]: Error: connect ETIMEDOUT 67.15.129.210:80
Sep 04 00:14:13 volumio volumio[859]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Sep 04 00:14:13 volumio volumio[859]: errno: -110,
Sep 04 00:14:13 volumio volumio[859]: code: 'ETIMEDOUT',
Sep 04 00:14:13 volumio volumio[859]: syscall: 'connect',
Sep 04 00:14:13 volumio volumio[859]: address: '67.15.129.210',
Sep 04 00:14:13 volumio volumio[859]: port: 80
Sep 04 00:14:13 volumio volumio[859]: }
Sep 04 00:14:13 volumio volumio[859]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 04 00:14:17 volumio sudo[1871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-04 00:13
Sep 04 00:14:17 volumio sudo[1871]: 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="cd8cf34b47ce852e70b71e6f7b6e0265f7fdb695"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="8f88153f9a18f312d56050e6613b45a852ac819a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 27 Sep 2023 11:35:49 AM CEST"
VOLUMIO_VERSION="3.546"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="6823c0d83061ff736b7e0dd4481bc496"