-- Logs begin at Mon 2025-02-24 20:31:40 HKT, end at Mon 2025-02-24 20:47:11 HKT. --
Feb 24 20:46:47 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Feb 24 20:46:47 volumio volumio[2812]: info: TuneIn handleBrowseUri: tunein/local
Feb 24 20:46:47 volumio systemd[1]: Starting Cleanup of Temporary Directories...
Feb 24 20:46:47 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded.
Feb 24 20:46:47 volumio systemd[1]: Started Cleanup of Temporary Directories.
Feb 24 20:46:48 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Feb 24 20:46:48 volumio volumio[2812]: info: TuneIn handleBrowseUri: tunein/local
Feb 24 20:46:49 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Feb 24 20:46:49 volumio volumio[2812]: info: TuneIn handleBrowseUri: tunein/local
Feb 24 20:46:51 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Feb 24 20:46:52 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Feb 24 20:46:53 volumio volumio[2812]: info: Preload queue cleared
Feb 24 20:46:53 volumio volumio[2812]: info: Preload queue cleared
Feb 24 20:47:03 volumio volumio[2812]: info: Preload queue cleared
Feb 24 20:47:03 volumio volumio[2812]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 24 20:47:03 volumio volumio[2812]: info: CoreStateMachine::ClearQueue
Feb 24 20:47:03 volumio volumio[2812]: info: CoreStateMachine::stop
Feb 24 20:47:03 volumio volumio[2812]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 24 20:47:03 volumio volumio[2812]: info: CorePlayQueue::clearPlayQueue
Feb 24 20:47:03 volumio volumio[2812]: info: CorePlayQueue::saveQueue
Feb 24 20:47:03 volumio volumio[2812]: info: CoreCommandRouter::volumioPushQueue
Feb 24 20:47:03 volumio volumio[2812]: info: CoreStateMachine::addQueueItems
Feb 24 20:47:03 volumio volumio[2812]: info: CorePlayQueue::addQueueItems
Feb 24 20:47:03 volumio volumio[2812]: info: Preload queue cleared
Feb 24 20:47:03 volumio volumio[2812]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99543066
Feb 24 20:47:03 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Feb 24 20:47:03 volumio volumio[2812]: info: CoreCommandRouter::volumioPushQueue
Feb 24 20:47:03 volumio volumio[2812]: info: CorePlayQueue::saveQueue
Feb 24 20:47:03 volumio volumio[2812]: info: CoreStateMachine::updateTrackBlock
Feb 24 20:47:03 volumio volumio[2812]: info: CorePlayQueue::getTrackBlock
Feb 24 20:47:03 volumio volumio[2812]: info: CoreCommandRouter::volumioPlay
Feb 24 20:47:03 volumio volumio[2812]: info: CoreStateMachine::play index 0
Feb 24 20:47:03 volumio volumio[2812]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 24 20:47:03 volumio volumio[2812]: info: CoreStateMachine::stop
Feb 24 20:47:03 volumio volumio[2812]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 24 20:47:03 volumio volumio[2812]: info: CoreStateMachine::play index undefined
Feb 24 20:47:03 volumio volumio[2812]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 24 20:47:03 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:03 volumio volumio[2812]: info: CoreStateMachine::startPlaybackTimer
Feb 24 20:47:03 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:03 volumio volumio[2812]: info: [1740401223185] ControllerWebradio::clearAddPlayTrack
Feb 24 20:47:03 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand stop
Feb 24 20:47:03 volumio volumio[2812]: info: sendMpdCommand stop took 2 milliseconds
Feb 24 20:47:03 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand clear
Feb 24 20:47:03 volumio volumio[2812]: info:
Feb 24 20:47:03 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:03 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:03 volumio volumio[2812]: info: sendMpdCommand clear took 1 milliseconds
Feb 24 20:47:03 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99543066"
Feb 24 20:47:03 volumio volumio[2812]: info:
Feb 24 20:47:03 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:03 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:03 volumio volumio[2812]: info:
Feb 24 20:47:03 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:03 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:03 volumio volumio[2812]: error: updateQueue error: null
Feb 24 20:47:03 volumio volumio[2812]: info: ------------------------------ 4ms
Feb 24 20:47:04 volumio volumio[2812]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99543066" took 1500 milliseconds
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 24 20:47:04 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand play
Feb 24 20:47:04 volumio volumio[2812]: info:
Feb 24 20:47:04 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:04 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:04 volumio volumio[2812]: info: ------------------------------ 1502ms
Feb 24 20:47:04 volumio volumio[2812]: info: ------------------------------ 1500ms
Feb 24 20:47:04 volumio volumio[2812]: info:
Feb 24 20:47:04 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:04 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:04 volumio volumio[2812]: info:
Feb 24 20:47:04 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:04 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:04 volumio volumio[2812]: info: sendMpdCommand play took 6 milliseconds
Feb 24 20:47:04 volumio volumio[2812]: info: ------------------------------ 7ms
Feb 24 20:47:04 volumio volumio[2812]: info: ------------------------------ 6ms
Feb 24 20:47:04 volumio volumio[2812]: info: ------------------------------ 5ms
Feb 24 20:47:04 volumio volumio[2812]: info: Preload queue cleared
Feb 24 20:47:04 volumio volumio[2812]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::ClearQueue
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::stop
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 24 20:47:04 volumio volumio[2812]: info: CorePlayQueue::clearPlayQueue
Feb 24 20:47:04 volumio volumio[2812]: info: CorePlayQueue::saveQueue
Feb 24 20:47:04 volumio volumio[2812]: info: CoreCommandRouter::volumioPushQueue
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::addQueueItems
Feb 24 20:47:04 volumio volumio[2812]: info: CorePlayQueue::addQueueItems
Feb 24 20:47:04 volumio volumio[2812]: info: Preload queue cleared
Feb 24 20:47:04 volumio volumio[2812]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99543066
Feb 24 20:47:04 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Feb 24 20:47:04 volumio volumio[2812]: info: CoreCommandRouter::volumioPushQueue
Feb 24 20:47:04 volumio volumio[2812]: info: CorePlayQueue::saveQueue
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::updateTrackBlock
Feb 24 20:47:04 volumio volumio[2812]: info: CorePlayQueue::getTrackBlock
Feb 24 20:47:04 volumio volumio[2812]: info: CoreCommandRouter::volumioPlay
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::play index 0
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::stop
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::play index undefined
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 24 20:47:04 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:04 volumio volumio[2812]: info: CoreStateMachine::startPlaybackTimer
Feb 24 20:47:04 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:04 volumio volumio[2812]: info: [1740401224865] ControllerWebradio::clearAddPlayTrack
Feb 24 20:47:04 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand stop
Feb 24 20:47:04 volumio volumio[2812]: info:
Feb 24 20:47:04 volumio volumio[2812]: ---------------------------- MPD announces state update: player
Feb 24 20:47:04 volumio volumio[2812]: info: sendMpdCommand stop took 4 milliseconds
Feb 24 20:47:04 volumio volumio[2812]: info: ControllerMpd::getState
Feb 24 20:47:04 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 20:47:04 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand clear
Feb 24 20:47:04 volumio volumio[2812]: info:
Feb 24 20:47:04 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:04 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:04 volumio volumio[2812]: info: sendMpdCommand status took 2 milliseconds
Feb 24 20:47:04 volumio volumio[2812]: info: sendMpdCommand clear took 1 milliseconds
Feb 24 20:47:04 volumio volumio[2812]: verbose: ControllerMpd::parseState
Feb 24 20:47:04 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 20:47:04 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99543066"
Feb 24 20:47:04 volumio volumio[2812]: info:
Feb 24 20:47:04 volumio volumio[2812]: ---------------------------- MPD announces state update: player
Feb 24 20:47:04 volumio volumio[2812]: info: ControllerMpd::getState
Feb 24 20:47:04 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 20:47:04 volumio volumio[2812]: info:
Feb 24 20:47:04 volumio volumio[2812]: ---------------------------- MPD announces state update: player
Feb 24 20:47:04 volumio volumio[2812]: info: ControllerMpd::getState
Feb 24 20:47:04 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 20:47:04 volumio volumio[2812]: error: updateQueue error: null
Feb 24 20:47:04 volumio volumio[2812]: info: ------------------------------ 5ms
Feb 24 20:47:04 volumio volumio[2812]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 24 20:47:04 volumio volumio[2812]: verbose: ControllerMpd::parseTrackInfo
Feb 24 20:47:04 volumio volumio[2812]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Feb 24 20:47:04 volumio volumio[2812]: info: ------------------------------ 9ms
Feb 24 20:47:05 volumio volumio[2812]: info:
Feb 24 20:47:05 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:05 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:05 volumio volumio[2812]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99543066" took 271 milliseconds
Feb 24 20:47:05 volumio volumio[2812]: info: sendMpdCommand status took 270 milliseconds
Feb 24 20:47:05 volumio volumio[2812]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 24 20:47:05 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand play
Feb 24 20:47:05 volumio volumio[2812]: verbose: ControllerMpd::parseState
Feb 24 20:47:05 volumio volumio[2812]: verbose: ControllerMpd::parseState
Feb 24 20:47:05 volumio volumio[2812]: info: ControllerMpd::pushState
Feb 24 20:47:05 volumio volumio[2812]: info: CoreCommandRouter::servicePushState
Feb 24 20:47:05 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:05 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 20:47:05 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:05 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:05 volumio volumio[2812]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 24 20:47:05 volumio volumio[2812]: verbose: CURRENT POSITION 0
Feb 24 20:47:05 volumio volumio[2812]: info: CoreStateMachine::syncState stateService stop
Feb 24 20:47:05 volumio volumio[2812]: info: CoreStateMachine::syncState currentStatus stop
Feb 24 20:47:05 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:05 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:05 volumio volumio[2812]: info: No code
Feb 24 20:47:05 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:05 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:05 volumio volumio[2812]: info: ControllerMpd::pushState
Feb 24 20:47:05 volumio volumio[2812]: info: CoreCommandRouter::servicePushState
Feb 24 20:47:05 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:05 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:05 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:05 volumio volumio[2812]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 24 20:47:05 volumio volumio[2812]: verbose: CURRENT POSITION 0
Feb 24 20:47:05 volumio volumio[2812]: info: CoreStateMachine::syncState stateService stop
Feb 24 20:47:05 volumio volumio[2812]: info: CoreStateMachine::syncState currentStatus stop
Feb 24 20:47:05 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:05 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:05 volumio volumio[2812]: info: No code
Feb 24 20:47:05 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:05 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:05 volumio volumio[2812]: info: ------------------------------ 317ms
Feb 24 20:47:05 volumio volumio[2812]: info: ------------------------------ 317ms
Feb 24 20:47:05 volumio volumio[2812]: info:
Feb 24 20:47:05 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:05 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:05 volumio volumio[2812]: info:
Feb 24 20:47:05 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:05 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:05 volumio volumio[2812]: info: ------------------------------ 52ms
Feb 24 20:47:05 volumio volumio[2812]: info: sendMpdCommand play took 50 milliseconds
Feb 24 20:47:05 volumio volumio[2812]: info: ------------------------------ 7ms
Feb 24 20:47:05 volumio volumio[2812]: info: ------------------------------ 6ms
Feb 24 20:47:06 volumio volumio[2812]: info:
Feb 24 20:47:06 volumio volumio[2812]: ---------------------------- MPD announces state update: player
Feb 24 20:47:06 volumio volumio[2812]: info: ControllerMpd::getState
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 20:47:06 volumio volumio[2812]: info:
Feb 24 20:47:06 volumio volumio[2812]: ---------------------------- MPD announces state update: player
Feb 24 20:47:06 volumio volumio[2812]: info: ControllerMpd::getState
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 20:47:06 volumio volumio[2812]: info:
Feb 24 20:47:06 volumio volumio[2812]: ---------------------------- MPD announces state update: player
Feb 24 20:47:06 volumio volumio[2812]: info: ControllerMpd::getState
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 20:47:06 volumio volumio[2812]: info: sendMpdCommand status took 4 milliseconds
Feb 24 20:47:06 volumio volumio[2812]: info: sendMpdCommand status took 3 milliseconds
Feb 24 20:47:06 volumio volumio[2812]: info: sendMpdCommand status took 4 milliseconds
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::parseState
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::parseState
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::parseState
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 20:47:06 volumio volumio[2812]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 24 20:47:06 volumio volumio[2812]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 24 20:47:06 volumio volumio[2812]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::parseTrackInfo
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::parseTrackInfo
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::parseTrackInfo
Feb 24 20:47:06 volumio volumio[2812]: info: ControllerMpd::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::servicePushState
Feb 24 20:47:06 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:06 volumio volumio[2812]: 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":"stream","artist":"(#1 - 342/6000) Clube FM 100.5 - Ribeir?o Preto/SP","album":null,"uri":"http://177.124.129.227:8069/stream","trackType":""}
Feb 24 20:47:06 volumio volumio[2812]: verbose: CURRENT POSITION 0
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::syncState stateService play
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::syncState currentStatus stop
Feb 24 20:47:06 volumio volumio[2812]: info: ControllerMpd::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::servicePushState
Feb 24 20:47:06 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:06 volumio volumio[2812]: 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":"stream","artist":"(#1 - 342/6000) Clube FM 100.5 - Ribeir?o Preto/SP","album":null,"uri":"http://177.124.129.227:8069/stream","trackType":""}
Feb 24 20:47:06 volumio volumio[2812]: verbose: CURRENT POSITION 0
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::syncState stateService play
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::syncState currentStatus play
Feb 24 20:47:06 volumio volumio[2812]: info: Received an update from plugin. extracting info from payload
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:06 volumio volumio[2812]: info: ControllerMpd::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::servicePushState
Feb 24 20:47:06 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:06 volumio volumio[2812]: 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":"stream","artist":"(#1 - 342/6000) Clube FM 100.5 - Ribeir?o Preto/SP","album":null,"uri":"http://177.124.129.227:8069/stream","trackType":""}
Feb 24 20:47:06 volumio volumio[2812]: verbose: CURRENT POSITION 0
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::syncState stateService play
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::syncState currentStatus play
Feb 24 20:47:06 volumio volumio[2812]: info: Received an update from plugin. extracting info from payload
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:06 volumio volumio[2812]: info: ------------------------------ 26ms
Feb 24 20:47:06 volumio volumio[2812]: info: ------------------------------ 44ms
Feb 24 20:47:06 volumio volumio[2812]: info: ------------------------------ 44ms
Feb 24 20:47:06 volumio volumio[2812]: info:
Feb 24 20:47:06 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:06 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:06 volumio volumio[2812]: info:
Feb 24 20:47:06 volumio volumio[2812]: ---------------------------- MPD announces state update: player
Feb 24 20:47:06 volumio volumio[2812]: info: ControllerMpd::getState
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 20:47:06 volumio volumio[2812]: info:
Feb 24 20:47:06 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:06 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:06 volumio volumio[2812]: info:
Feb 24 20:47:06 volumio volumio[2812]: ---------------------------- MPD announces state update: player
Feb 24 20:47:06 volumio volumio[2812]: info: ControllerMpd::getState
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 20:47:06 volumio volumio[2812]: info:
Feb 24 20:47:06 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:06 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:06 volumio volumio[2812]: info:
Feb 24 20:47:06 volumio volumio[2812]: ---------------------------- MPD announces state update: player
Feb 24 20:47:06 volumio volumio[2812]: info: ControllerMpd::getState
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 20:47:06 volumio volumio[2812]: info: ------------------------------ 6ms
Feb 24 20:47:06 volumio volumio[2812]: info: sendMpdCommand status took 5 milliseconds
Feb 24 20:47:06 volumio volumio[2812]: info: ------------------------------ 6ms
Feb 24 20:47:06 volumio volumio[2812]: info: sendMpdCommand status took 5 milliseconds
Feb 24 20:47:06 volumio volumio[2812]: info: ------------------------------ 4ms
Feb 24 20:47:06 volumio volumio[2812]: info: sendMpdCommand status took 3 milliseconds
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::parseState
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::parseState
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::parseState
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 20:47:06 volumio volumio[2812]: info: sendMpdCommand playlistinfo took 12 milliseconds
Feb 24 20:47:06 volumio volumio[2812]: info: sendMpdCommand playlistinfo took 13 milliseconds
Feb 24 20:47:06 volumio volumio[2812]: verbose: ControllerMpd::parseTrackInfo
Feb 24 20:47:06 volumio volumio[2812]: info: ControllerMpd::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::servicePushState
Feb 24 20:47:06 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:06 volumio volumio[2812]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Clube FM 100.5 - Ribeirão Preto/SP","album":null,"uri":"http://177.124.129.227:8069/stream","trackType":""}
Feb 24 20:47:06 volumio volumio[2812]: verbose: CURRENT POSITION 0
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::syncState stateService play
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::syncState currentStatus play
Feb 24 20:47:06 volumio volumio[2812]: info: Received an update from plugin. extracting info from payload
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:06 volumio volumio[2812]: info: ControllerMpd::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::servicePushState
Feb 24 20:47:06 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:06 volumio volumio[2812]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Clube FM 100.5 - Ribeirão Preto/SP","album":null,"uri":"http://177.124.129.227:8069/stream","trackType":""}
Feb 24 20:47:06 volumio volumio[2812]: verbose: CURRENT POSITION 0
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::syncState stateService play
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::syncState currentStatus play
Feb 24 20:47:06 volumio volumio[2812]: info: Received an update from plugin. extracting info from payload
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:06 volumio volumio[2812]: info: ControllerMpd::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::servicePushState
Feb 24 20:47:06 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:06 volumio volumio[2812]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Clube FM 100.5 - Ribeirão Preto/SP","album":null,"uri":"http://177.124.129.227:8069/stream","trackType":""}
Feb 24 20:47:06 volumio volumio[2812]: verbose: CURRENT POSITION 0
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::syncState stateService play
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::syncState currentStatus play
Feb 24 20:47:06 volumio volumio[2812]: info: Received an update from plugin. extracting info from payload
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:06 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:06 volumio volumio[2812]: info: ------------------------------ 74ms
Feb 24 20:47:06 volumio volumio[2812]: info: ------------------------------ 73ms
Feb 24 20:47:06 volumio volumio[2812]: info: ------------------------------ 74ms
Feb 24 20:47:07 volumio volumio[2812]: info:
Feb 24 20:47:07 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:07 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:07 volumio volumio[2812]: info:
Feb 24 20:47:07 volumio volumio[2812]: ---------------------------- MPD announces state update: player
Feb 24 20:47:07 volumio volumio[2812]: info: ControllerMpd::getState
Feb 24 20:47:07 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 20:47:07 volumio volumio[2812]: info:
Feb 24 20:47:07 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:07 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:07 volumio volumio[2812]: info:
Feb 24 20:47:07 volumio volumio[2812]: ---------------------------- MPD announces state update: player
Feb 24 20:47:07 volumio volumio[2812]: info: ControllerMpd::getState
Feb 24 20:47:07 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 20:47:07 volumio volumio[2812]: info:
Feb 24 20:47:07 volumio volumio[2812]: ---------------------------- MPD announces system playlist update
Feb 24 20:47:07 volumio volumio[2812]: info: Ignoring MPD Status Update
Feb 24 20:47:07 volumio volumio[2812]: info:
Feb 24 20:47:07 volumio volumio[2812]: ---------------------------- MPD announces state update: player
Feb 24 20:47:07 volumio volumio[2812]: info: ControllerMpd::getState
Feb 24 20:47:07 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 20:47:07 volumio volumio[2812]: info: ------------------------------ 9ms
Feb 24 20:47:07 volumio volumio[2812]: info: sendMpdCommand status took 7 milliseconds
Feb 24 20:47:07 volumio volumio[2812]: info: ------------------------------ 6ms
Feb 24 20:47:07 volumio volumio[2812]: info: sendMpdCommand status took 5 milliseconds
Feb 24 20:47:07 volumio volumio[2812]: info: ------------------------------ 5ms
Feb 24 20:47:07 volumio volumio[2812]: info: sendMpdCommand status took 4 milliseconds
Feb 24 20:47:07 volumio volumio[2812]: verbose: ControllerMpd::parseState
Feb 24 20:47:07 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 20:47:07 volumio volumio[2812]: verbose: ControllerMpd::parseState
Feb 24 20:47:07 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 20:47:07 volumio volumio[2812]: verbose: ControllerMpd::parseState
Feb 24 20:47:07 volumio volumio[2812]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 20:47:07 volumio volumio[2812]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 24 20:47:07 volumio volumio[2812]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 24 20:47:07 volumio volumio[2812]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 24 20:47:07 volumio volumio[2812]: verbose: ControllerMpd::parseTrackInfo
Feb 24 20:47:07 volumio volumio[2812]: verbose: ControllerMpd::parseTrackInfo
Feb 24 20:47:07 volumio volumio[2812]: verbose: ControllerMpd::parseTrackInfo
Feb 24 20:47:07 volumio volumio[2812]: info: ControllerMpd::pushState
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::servicePushState
Feb 24 20:47:07 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:07 volumio volumio[2812]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1582,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Now Playing info goes here","artist":"Clube FM 100.5 - Ribeirão Preto/SP","album":null,"uri":"http://177.124.129.227:8069/stream","trackType":""}
Feb 24 20:47:07 volumio volumio[2812]: verbose: CURRENT POSITION 0
Feb 24 20:47:07 volumio volumio[2812]: info: CoreStateMachine::syncState stateService play
Feb 24 20:47:07 volumio volumio[2812]: info: CoreStateMachine::syncState currentStatus play
Feb 24 20:47:07 volumio volumio[2812]: info: Received an update from plugin. extracting info from payload
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 24 20:47:07 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:07 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:07 volumio volumio[2812]: info: ControllerMpd::pushState
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::servicePushState
Feb 24 20:47:07 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:07 volumio volumio[2812]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1582,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Now Playing info goes here","artist":"Clube FM 100.5 - Ribeirão Preto/SP","album":null,"uri":"http://177.124.129.227:8069/stream","trackType":""}
Feb 24 20:47:07 volumio volumio[2812]: verbose: CURRENT POSITION 0
Feb 24 20:47:07 volumio volumio[2812]: info: CoreStateMachine::syncState stateService play
Feb 24 20:47:07 volumio volumio[2812]: info: CoreStateMachine::syncState currentStatus play
Feb 24 20:47:07 volumio volumio[2812]: info: Received an update from plugin. extracting info from payload
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 24 20:47:07 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:07 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:07 volumio volumio[2812]: info: ControllerMpd::pushState
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::servicePushState
Feb 24 20:47:07 volumio volumio[2812]: info: CorePlayQueue::getTrack 0
Feb 24 20:47:07 volumio volumio[2812]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1582,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Now Playing info goes here","artist":"Clube FM 100.5 - Ribeirão Preto/SP","album":null,"uri":"http://177.124.129.227:8069/stream","trackType":""}
Feb 24 20:47:07 volumio volumio[2812]: verbose: CURRENT POSITION 0
Feb 24 20:47:07 volumio volumio[2812]: info: CoreStateMachine::syncState stateService play
Feb 24 20:47:07 volumio volumio[2812]: info: CoreStateMachine::syncState currentStatus play
Feb 24 20:47:07 volumio volumio[2812]: info: Received an update from plugin. extracting info from payload
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 24 20:47:07 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:07 volumio volumio[2812]: info: CoreStateMachine::pushState
Feb 24 20:47:07 volumio volumio[2812]: info: CoreCommandRouter::volumioPushState
Feb 24 20:47:07 volumio volumio[2812]: info: ------------------------------ 65ms
Feb 24 20:47:07 volumio volumio[2812]: info: ------------------------------ 61ms
Feb 24 20:47:11 volumio volumio[2812]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 24 20:47:11 volumio volumio[2812]: Error: connect ECONNREFUSED 47.88.58.234:80
Feb 24 20:47:11 volumio volumio[2812]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Feb 24 20:47:11 volumio volumio[2812]: errno: -111,
Feb 24 20:47:11 volumio volumio[2812]: code: 'ECONNREFUSED',
Feb 24 20:47:11 volumio volumio[2812]: syscall: 'connect',
Feb 24 20:47:11 volumio volumio[2812]: address: '47.88.58.234',
Feb 24 20:47:11 volumio volumio[2812]: port: 80
Feb 24 20:47:11 volumio volumio[2812]: }
Feb 24 20:47:11 volumio volumio[2812]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 24 20:47:11 volumio sudo[4687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-24 20:46
Feb 24 20:47:11 volumio sudo[4687]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"