-- Logs begin at Mon 2025-06-30 12:38:48 UTC, end at Mon 2025-06-30 13:47:35 UTC. --
Jun 30 13:46:04 volumio volumio[784]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::ClearQueue
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::stop
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:46:04 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::stPlaybackTimer
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::updateTrackBlock
Jun 30 13:46:04 volumio volumio[784]: info: CorePlayQueue::getTrackBlock
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:04 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:04 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:04 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::serviceStop
Jun 30 13:46:04 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:04 volumio volumio[784]: info: CoreCommandRouter::serviceStop
Jun 30 13:46:04 volumio volumio[784]: info: [1751291164643] ControllerWebradio::stop
Jun 30 13:46:04 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand stop
Jun 30 13:46:04 volumio volumio[784]: info: CorePlayQueue::clearPlayQueue
Jun 30 13:46:04 volumio volumio[784]: info: CorePlayQueue::saveQueue
Jun 30 13:46:04 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:04 volumio volumio[784]: info: CoreCommandRouter::volumioPushQueue
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::addQueueItems
Jun 30 13:46:04 volumio volumio[784]: info: CorePlayQueue::addQueueItems
Jun 30 13:46:04 volumio volumio[784]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1628130
Jun 30 13:46:04 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jun 30 13:46:04 volumio volumio[784]: info: CorePlayQueue::saveQueue
Jun 30 13:46:04 volumio volumio[784]: info: CoreCommandRouter::volumioPushQueue
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::updateTrackBlock
Jun 30 13:46:04 volumio volumio[784]: info: CorePlayQueue::getTrackBlock
Jun 30 13:46:04 volumio volumio[784]: info: CoreCommandRouter::volumioPlay
Jun 30 13:46:04 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::play index 0
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::stop
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:46:04 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::play index undefined
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:46:04 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::startPlaybackTimer
Jun 30 13:46:04 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:04 volumio volumio[784]: info: [1751291164660] ControllerWebradio::clearAddPlayTrack
Jun 30 13:46:04 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand stop
Jun 30 13:46:04 volumio volumio[784]: info:
Jun 30 13:46:04 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:04 volumio volumio[784]: info: sendMpdCommand stop took 65 milliseconds
Jun 30 13:46:04 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:04 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:04 volumio volumio[784]: info: sendMpdCommand stop took 49 milliseconds
Jun 30 13:46:04 volumio volumio[784]: info: sendMpdCommand status took 1 milliseconds
Jun 30 13:46:04 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand clear
Jun 30 13:46:04 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:04 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:04 volumio volumio[784]: info:
Jun 30 13:46:04 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:04 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:04 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:04 volumio volumio[784]: info:
Jun 30 13:46:04 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:04 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:04 volumio volumio[784]: info: sendMpdCommand clear took 2 milliseconds
Jun 30 13:46:04 volumio volumio[784]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 30 13:46:04 volumio volumio[784]: info: sendMpdCommand status took 1 milliseconds
Jun 30 13:46:04 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1628130"
Jun 30 13:46:04 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:04 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:04 volumio volumio[784]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 30 13:46:04 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:04 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:04 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:04 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:04 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:04 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:04 volumio volumio[784]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jun 30 13:46:04 volumio volumio[784]: info: ------------------------------ 12ms
Jun 30 13:46:04 volumio volumio[784]: info: ------------------------------ 13ms
Jun 30 13:46:04 volumio volumio[784]: info:
Jun 30 13:46:04 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:04 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:04 volumio volumio[784]: error: updateQueue error: null
Jun 30 13:46:04 volumio volumio[784]: info: ------------------------------ 15ms
Jun 30 13:46:04 volumio volumio[784]: info:
Jun 30 13:46:04 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:04 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:04 volumio volumio[784]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1628130" took 259 milliseconds
Jun 30 13:46:04 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 30 13:46:04 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand play
Jun 30 13:46:04 volumio volumio[784]: info: ------------------------------ 250ms
Jun 30 13:46:04 volumio volumio[784]: info:
Jun 30 13:46:04 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:04 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:04 volumio volumio[784]: info: ------------------------------ 4ms
Jun 30 13:46:04 volumio volumio[784]: info: sendMpdCommand play took 3 milliseconds
Jun 30 13:46:04 volumio volumio[784]: info: ------------------------------ 2ms
Jun 30 13:46:05 volumio volumio[784]: info:
Jun 30 13:46:05 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:05 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:05 volumio volumio[784]: info:
Jun 30 13:46:05 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:05 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:05 volumio volumio[784]: info:
Jun 30 13:46:05 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:05 volumio volumio[784]: info: sendMpdCommand status took 3 milliseconds
Jun 30 13:46:05 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:05 volumio volumio[784]: info: sendMpdCommand status took 2 milliseconds
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:05 volumio volumio[784]: info:
Jun 30 13:46:05 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:05 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:05 volumio volumio[784]: info: sendMpdCommand status took 2 milliseconds
Jun 30 13:46:05 volumio volumio[784]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jun 30 13:46:05 volumio volumio[784]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:05 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:05 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:05 volumio volumio[784]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"103.253.132.4:5004","artist":"COOLfahrenheit | Easy Listening","album":null,"uri":"http://103.253.132.4:5004","trackType":"4:5004"}
Jun 30 13:46:05 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus stop
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:05 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:05 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:05 volumio volumio[784]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"103.253.132.4:5004","artist":"COOLfahrenheit | Easy Listening","album":null,"uri":"http://103.253.132.4:5004","trackType":"4:5004"}
Jun 30 13:46:05 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:05 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:05 volumio volumio[784]: info: ------------------------------ 22ms
Jun 30 13:46:05 volumio volumio[784]: info: ------------------------------ 22ms
Jun 30 13:46:05 volumio volumio[784]: info: sendMpdCommand status took 18 milliseconds
Jun 30 13:46:05 volumio volumio[784]: info: sendMpdCommand playlistinfo took 18 milliseconds
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:05 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:05 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:05 volumio volumio[784]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"103.253.132.4:5004","artist":"COOLfahrenheit | Easy Listening","album":null,"uri":"http://103.253.132.4:5004","trackType":"4:5004"}
Jun 30 13:46:05 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:05 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:05 volumio volumio[784]: info: ------------------------------ 32ms
Jun 30 13:46:05 volumio volumio[784]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:05 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:05 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:05 volumio volumio[784]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"103.253.132.4:5004","artist":"COOLfahrenheit | Easy Listening","album":null,"uri":"http://103.253.132.4:5004","trackType":"4:5004"}
Jun 30 13:46:05 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:05 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:05 volumio volumio[784]: info: ------------------------------ 49ms
Jun 30 13:46:05 volumio volumio[784]: info:
Jun 30 13:46:05 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:05 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:05 volumio volumio[784]: info:
Jun 30 13:46:05 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:05 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:05 volumio volumio[784]: info:
Jun 30 13:46:05 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:05 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:05 volumio volumio[784]: info:
Jun 30 13:46:05 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:05 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:05 volumio volumio[784]: info: ------------------------------ 3ms
Jun 30 13:46:05 volumio volumio[784]: info: sendMpdCommand status took 3 milliseconds
Jun 30 13:46:05 volumio volumio[784]: info: ------------------------------ 3ms
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:05 volumio volumio[784]: info: sendMpdCommand status took 3 milliseconds
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:05 volumio volumio[784]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:05 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:05 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:05 volumio volumio[784]: verbose: STATE SERVICE {"status":"play","position":0,"seek":863,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Music Freeze Your Mind","artist":"COOLfahrenheit | Easy Listening","album":null,"uri":"http://103.253.132.4:5004","trackType":"4:5004"}
Jun 30 13:46:05 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:05 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:05 volumio volumio[784]: info: ------------------------------ 15ms
Jun 30 13:46:05 volumio volumio[784]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jun 30 13:46:05 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:05 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:05 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:05 volumio volumio[784]: verbose: STATE SERVICE {"status":"play","position":0,"seek":863,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Music Freeze Your Mind","artist":"COOLfahrenheit | Easy Listening","album":null,"uri":"http://103.253.132.4:5004","trackType":"4:5004"}
Jun 30 13:46:05 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:05 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:05 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:05 volumio volumio[784]: info: ------------------------------ 28ms
Jun 30 13:46:19 volumio volumio[784]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::ClearQueue
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::stop
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:46:19 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::stPlaybackTimer
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::updateTrackBlock
Jun 30 13:46:19 volumio volumio[784]: info: CorePlayQueue::getTrackBlock
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:19 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:19 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:19 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::serviceStop
Jun 30 13:46:19 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:19 volumio volumio[784]: info: CoreCommandRouter::serviceStop
Jun 30 13:46:19 volumio volumio[784]: info: [1751291179012] ControllerWebradio::stop
Jun 30 13:46:19 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand stop
Jun 30 13:46:19 volumio volumio[784]: info: CorePlayQueue::clearPlayQueue
Jun 30 13:46:19 volumio volumio[784]: info: CorePlayQueue::saveQueue
Jun 30 13:46:19 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:19 volumio volumio[784]: info: CoreCommandRouter::volumioPushQueue
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::addQueueItems
Jun 30 13:46:19 volumio volumio[784]: info: CorePlayQueue::addQueueItems
Jun 30 13:46:19 volumio volumio[784]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1477271
Jun 30 13:46:19 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jun 30 13:46:19 volumio volumio[784]: info: CorePlayQueue::saveQueue
Jun 30 13:46:19 volumio volumio[784]: info: CoreCommandRouter::volumioPushQueue
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::updateTrackBlock
Jun 30 13:46:19 volumio volumio[784]: info: CorePlayQueue::getTrackBlock
Jun 30 13:46:19 volumio volumio[784]: info: CoreCommandRouter::volumioPlay
Jun 30 13:46:19 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::play index 0
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::stop
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:46:19 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::play index undefined
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:46:19 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::startPlaybackTimer
Jun 30 13:46:19 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:19 volumio volumio[784]: info: [1751291179028] ControllerWebradio::clearAddPlayTrack
Jun 30 13:46:19 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand stop
Jun 30 13:46:19 volumio volumio[784]: info:
Jun 30 13:46:19 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:19 volumio volumio[784]: info: sendMpdCommand stop took 21 milliseconds
Jun 30 13:46:19 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:19 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:19 volumio volumio[784]: info: sendMpdCommand stop took 5 milliseconds
Jun 30 13:46:19 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand clear
Jun 30 13:46:19 volumio volumio[784]: info:
Jun 30 13:46:19 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:19 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:19 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:19 volumio volumio[784]: info:
Jun 30 13:46:19 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:19 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:19 volumio volumio[784]: info: sendMpdCommand status took 3 milliseconds
Jun 30 13:46:19 volumio volumio[784]: info: sendMpdCommand clear took 2 milliseconds
Jun 30 13:46:19 volumio volumio[784]: info: sendMpdCommand status took 1 milliseconds
Jun 30 13:46:19 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:19 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:19 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1477271"
Jun 30 13:46:19 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:19 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:19 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:19 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:19 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:19 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:19 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:19 volumio volumio[784]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jun 30 13:46:19 volumio volumio[784]: info: ------------------------------ 13ms
Jun 30 13:46:19 volumio volumio[784]: info:
Jun 30 13:46:19 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:19 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:19 volumio volumio[784]: error: updateQueue error: null
Jun 30 13:46:19 volumio volumio[784]: info: ------------------------------ 14ms
Jun 30 13:46:19 volumio volumio[784]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jun 30 13:46:19 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:19 volumio volumio[784]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 30 13:46:19 volumio volumio[784]: info: ------------------------------ 19ms
Jun 30 13:46:19 volumio volumio[784]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1477271" took 850 milliseconds
Jun 30 13:46:19 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 30 13:46:19 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand play
Jun 30 13:46:19 volumio volumio[784]: info:
Jun 30 13:46:19 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:19 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:19 volumio volumio[784]: info: ------------------------------ 841ms
Jun 30 13:46:19 volumio volumio[784]: info:
Jun 30 13:46:19 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:19 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:19 volumio volumio[784]: info: sendMpdCommand play took 3 milliseconds
Jun 30 13:46:19 volumio volumio[784]: info: ------------------------------ 2ms
Jun 30 13:46:19 volumio volumio[784]: info: ------------------------------ 1ms
Jun 30 13:46:20 volumio volumio[784]: info:
Jun 30 13:46:20 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:20 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:20 volumio volumio[784]: info:
Jun 30 13:46:20 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:20 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:20 volumio volumio[784]: info:
Jun 30 13:46:20 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:20 volumio volumio[784]: info: sendMpdCommand status took 2 milliseconds
Jun 30 13:46:20 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:20 volumio volumio[784]: info: sendMpdCommand status took 2 milliseconds
Jun 30 13:46:20 volumio volumio[784]: info: sendMpdCommand status took 2 milliseconds
Jun 30 13:46:20 volumio volumio[784]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:20 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:20 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:20 volumio volumio[784]: 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":"2585_128.mp3","artist":"SmoothJazz.com Global","album":null,"uri":"http://216.235.80.88:80/2585_128.mp3","trackType":"mp3"}
Jun 30 13:46:20 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus stop
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:20 volumio volumio[784]: info: ------------------------------ 11ms
Jun 30 13:46:20 volumio volumio[784]: info:
Jun 30 13:46:20 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:20 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:20 volumio volumio[784]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jun 30 13:46:20 volumio volumio[784]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:20 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:20 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:20 volumio volumio[784]: 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":"2585_128.mp3","artist":"SmoothJazz.com Global","album":null,"uri":"http://216.235.80.88:80/2585_128.mp3","trackType":"mp3"}
Jun 30 13:46:20 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:20 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:20 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:20 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:20 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:20 volumio volumio[784]: 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":"2585_128.mp3","artist":"SmoothJazz.com Global","album":null,"uri":"http://216.235.80.88:80/2585_128.mp3","trackType":"mp3"}
Jun 30 13:46:20 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:20 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:20 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:20 volumio volumio[784]: info: ------------------------------ 30ms
Jun 30 13:46:20 volumio volumio[784]: info: ------------------------------ 29ms
Jun 30 13:46:20 volumio volumio[784]: info: sendMpdCommand status took 26 milliseconds
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:20 volumio volumio[784]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jun 30 13:46:20 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:20 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:20 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:20 volumio volumio[784]: 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":"2585_128.mp3","artist":"SmoothJazz.com Global","album":null,"uri":"http://216.235.80.88:80/2585_128.mp3","trackType":"mp3"}
Jun 30 13:46:20 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:20 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:20 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:20 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:20 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:20 volumio volumio[784]: info: ------------------------------ 48ms
Jun 30 13:46:21 volumio volumio[784]: info:
Jun 30 13:46:21 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:21 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:21 volumio volumio[784]: info:
Jun 30 13:46:21 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:21 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:21 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:21 volumio volumio[784]: info: ------------------------------ 1ms
Jun 30 13:46:21 volumio volumio[784]: info: sendMpdCommand status took 1 milliseconds
Jun 30 13:46:21 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:21 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:21 volumio volumio[784]: info:
Jun 30 13:46:21 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:21 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:21 volumio volumio[784]: info:
Jun 30 13:46:21 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:21 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:21 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:21 volumio volumio[784]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 30 13:46:21 volumio volumio[784]: info: ------------------------------ 2ms
Jun 30 13:46:21 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:21 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:21 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:21 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:21 volumio volumio[784]: 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":"Larry Carlton - High Steppin' ","artist":"SmoothJazz.com","album":null,"uri":"http://216.235.80.88:80/2585_128.mp3","trackType":"mp3"}
Jun 30 13:46:21 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:21 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:21 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:21 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:21 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:21 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:21 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:21 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:21 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:21 volumio volumio[784]: info: ------------------------------ 13ms
Jun 30 13:46:21 volumio volumio[784]: info: sendMpdCommand status took 11 milliseconds
Jun 30 13:46:21 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:21 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:21 volumio volumio[784]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 30 13:46:21 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:21 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:21 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:21 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:21 volumio volumio[784]: 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":"Larry Carlton - High Steppin' ","artist":"SmoothJazz.com","album":null,"uri":"http://216.235.80.88:80/2585_128.mp3","trackType":"mp3"}
Jun 30 13:46:21 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:21 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:21 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:21 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:21 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:21 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:21 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:21 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:21 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:21 volumio volumio[784]: info: ------------------------------ 26ms
Jun 30 13:46:44 volumio volumio[784]: info:
Jun 30 13:46:44 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:44 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:44 volumio volumio[784]: info:
Jun 30 13:46:44 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:44 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:44 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:44 volumio volumio[784]: info:
Jun 30 13:46:44 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:44 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:44 volumio volumio[784]: info:
Jun 30 13:46:44 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:44 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:44 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:44 volumio volumio[784]: info: ------------------------------ 3ms
Jun 30 13:46:44 volumio volumio[784]: info: sendMpdCommand status took 3 milliseconds
Jun 30 13:46:44 volumio volumio[784]: info: ------------------------------ 3ms
Jun 30 13:46:44 volumio volumio[784]: info: sendMpdCommand status took 2 milliseconds
Jun 30 13:46:44 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:44 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:44 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:44 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:44 volumio volumio[784]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 30 13:46:44 volumio volumio[784]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 30 13:46:44 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:44 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:44 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:44 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:44 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:44 volumio volumio[784]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15965,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Kimberly Brewer - If I Ever Lose This Heaven feat Ragan Whiteside ","artist":"SmoothJazz.com","album":null,"uri":"http://216.235.80.88:80/2585_128.mp3","trackType":"mp3"}
Jun 30 13:46:44 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:44 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:44 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:44 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:44 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:44 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:44 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:44 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:44 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:44 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:44 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:44 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:44 volumio volumio[784]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15965,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Kimberly Brewer - If I Ever Lose This Heaven feat Ragan Whiteside ","artist":"SmoothJazz.com","album":null,"uri":"http://216.235.80.88:80/2585_128.mp3","trackType":"mp3"}
Jun 30 13:46:44 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:44 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:44 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:44 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:44 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:44 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:44 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:44 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:44 volumio volumio[784]: info: ------------------------------ 30ms
Jun 30 13:46:44 volumio volumio[784]: info: ------------------------------ 30ms
Jun 30 13:46:50 volumio volumio[784]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::ClearQueue
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::stop
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:46:50 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::stPlaybackTimer
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::updateTrackBlock
Jun 30 13:46:50 volumio volumio[784]: info: CorePlayQueue::getTrackBlock
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:50 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:50 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:50 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::serviceStop
Jun 30 13:46:50 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:50 volumio volumio[784]: info: CoreCommandRouter::serviceStop
Jun 30 13:46:50 volumio volumio[784]: info: [1751291210279] ControllerWebradio::stop
Jun 30 13:46:50 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand stop
Jun 30 13:46:50 volumio volumio[784]: info: CorePlayQueue::clearPlayQueue
Jun 30 13:46:50 volumio volumio[784]: info: CorePlayQueue::saveQueue
Jun 30 13:46:50 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:50 volumio volumio[784]: info: CoreCommandRouter::volumioPushQueue
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::addQueueItems
Jun 30 13:46:50 volumio volumio[784]: info: CorePlayQueue::addQueueItems
Jun 30 13:46:50 volumio volumio[784]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99602766
Jun 30 13:46:50 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jun 30 13:46:50 volumio volumio[784]: info: CorePlayQueue::saveQueue
Jun 30 13:46:50 volumio volumio[784]: info: CoreCommandRouter::volumioPushQueue
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::updateTrackBlock
Jun 30 13:46:50 volumio volumio[784]: info: CorePlayQueue::getTrackBlock
Jun 30 13:46:50 volumio volumio[784]: info: CoreCommandRouter::volumioPlay
Jun 30 13:46:50 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::play index 0
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::stop
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:46:50 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::play index undefined
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:46:50 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::startPlaybackTimer
Jun 30 13:46:50 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:50 volumio volumio[784]: info: [1751291210292] ControllerWebradio::clearAddPlayTrack
Jun 30 13:46:50 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand stop
Jun 30 13:46:50 volumio volumio[784]: info:
Jun 30 13:46:50 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:50 volumio volumio[784]: info: sendMpdCommand stop took 17 milliseconds
Jun 30 13:46:50 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:50 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:50 volumio volumio[784]: info: sendMpdCommand stop took 3 milliseconds
Jun 30 13:46:50 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand clear
Jun 30 13:46:50 volumio volumio[784]: info:
Jun 30 13:46:50 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:50 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:50 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:50 volumio volumio[784]: info:
Jun 30 13:46:50 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:50 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:50 volumio volumio[784]: info: sendMpdCommand status took 3 milliseconds
Jun 30 13:46:50 volumio volumio[784]: info: sendMpdCommand clear took 2 milliseconds
Jun 30 13:46:50 volumio volumio[784]: info: sendMpdCommand status took 1 milliseconds
Jun 30 13:46:50 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:50 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:50 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99602766"
Jun 30 13:46:50 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:50 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:50 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:50 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:50 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:50 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:50 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:50 volumio volumio[784]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jun 30 13:46:50 volumio volumio[784]: info: ------------------------------ 14ms
Jun 30 13:46:50 volumio volumio[784]: info:
Jun 30 13:46:50 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:50 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:50 volumio volumio[784]: error: updateQueue error: null
Jun 30 13:46:50 volumio volumio[784]: info: ------------------------------ 15ms
Jun 30 13:46:50 volumio volumio[784]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jun 30 13:46:50 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:50 volumio volumio[784]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 30 13:46:50 volumio volumio[784]: info: ------------------------------ 19ms
Jun 30 13:46:50 volumio volumio[784]: info:
Jun 30 13:46:50 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:50 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:50 volumio volumio[784]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99602766" took 290 milliseconds
Jun 30 13:46:50 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 30 13:46:50 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand play
Jun 30 13:46:50 volumio volumio[784]: info: ------------------------------ 279ms
Jun 30 13:46:50 volumio volumio[784]: info: ------------------------------ 2ms
Jun 30 13:46:50 volumio volumio[784]: info:
Jun 30 13:46:50 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:50 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:50 volumio volumio[784]: info: sendMpdCommand play took 4 milliseconds
Jun 30 13:46:50 volumio volumio[784]: info: ------------------------------ 2ms
Jun 30 13:46:52 volumio volumio[784]: info:
Jun 30 13:46:52 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:52 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:52 volumio volumio[784]: info:
Jun 30 13:46:52 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:52 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:52 volumio volumio[784]: info:
Jun 30 13:46:52 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:52 volumio volumio[784]: info: sendMpdCommand status took 3 milliseconds
Jun 30 13:46:52 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:52 volumio volumio[784]: info: sendMpdCommand status took 3 milliseconds
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:52 volumio volumio[784]: info:
Jun 30 13:46:52 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:52 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:52 volumio volumio[784]: info: sendMpdCommand status took 2 milliseconds
Jun 30 13:46:52 volumio volumio[784]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 30 13:46:52 volumio volumio[784]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:52 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:52 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:52 volumio volumio[784]: 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":"radio.mp3","artist":"(#1 - 18/1000) Hank's Gumshoe Old Time Radio","album":null,"uri":"https://1670am.net:8040/radio.mp3","trackType":"mp3"}
Jun 30 13:46:52 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus stop
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:52 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:52 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:52 volumio volumio[784]: 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":"radio.mp3","artist":"(#1 - 18/1000) Hank's Gumshoe Old Time Radio","album":null,"uri":"https://1670am.net:8040/radio.mp3","trackType":"mp3"}
Jun 30 13:46:52 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:52 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:52 volumio volumio[784]: info: ------------------------------ 21ms
Jun 30 13:46:52 volumio volumio[784]: info: ------------------------------ 20ms
Jun 30 13:46:52 volumio volumio[784]: info: sendMpdCommand status took 17 milliseconds
Jun 30 13:46:52 volumio volumio[784]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:52 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:52 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:52 volumio volumio[784]: 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":"radio.mp3","artist":"(#1 - 18/1000) Hank's Gumshoe Old Time Radio","album":null,"uri":"https://1670am.net:8040/radio.mp3","trackType":"mp3"}
Jun 30 13:46:52 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:52 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:52 volumio volumio[784]: info: ------------------------------ 31ms
Jun 30 13:46:52 volumio volumio[784]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:52 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:52 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:52 volumio volumio[784]: 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":"radio.mp3","artist":"(#1 - 18/1000) Hank's Gumshoe Old Time Radio","album":null,"uri":"https://1670am.net:8040/radio.mp3","trackType":"mp3"}
Jun 30 13:46:52 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:52 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:52 volumio volumio[784]: info: ------------------------------ 50ms
Jun 30 13:46:52 volumio volumio[784]: info:
Jun 30 13:46:52 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:52 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:52 volumio volumio[784]: info:
Jun 30 13:46:52 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:52 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:52 volumio volumio[784]: info:
Jun 30 13:46:52 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:46:52 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:46:52 volumio volumio[784]: info:
Jun 30 13:46:52 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:46:52 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:46:52 volumio volumio[784]: info: ------------------------------ 3ms
Jun 30 13:46:52 volumio volumio[784]: info: sendMpdCommand status took 2 milliseconds
Jun 30 13:46:52 volumio volumio[784]: info: ------------------------------ 1ms
Jun 30 13:46:52 volumio volumio[784]: info: sendMpdCommand status took 2 milliseconds
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:46:52 volumio volumio[784]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jun 30 13:46:52 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:46:52 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:52 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:52 volumio volumio[784]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ID - ST","artist":"Hank's Gumshoe Old Time Radio","album":null,"uri":"https://1670am.net:8040/radio.mp3","trackType":"mp3"}
Jun 30 13:46:52 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:52 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:52 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:46:52 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:46:52 volumio volumio[784]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ID - ST","artist":"Hank's Gumshoe Old Time Radio","album":null,"uri":"https://1670am.net:8040/radio.mp3","trackType":"mp3"}
Jun 30 13:46:52 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:46:52 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:46:52 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:46:52 volumio volumio[784]: info: ------------------------------ 24ms
Jun 30 13:46:52 volumio volumio[784]: info: ------------------------------ 24ms
Jun 30 13:46:55 volumio volumio[784]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/(%231%20-%2018%2F1000)%20Hank's%20Gumshoe%20Old%20Time%20Radio/0fb84c15-b666-4671-a823-ffc25b5f9a7e.jpg'
Jun 30 13:47:00 volumio volumio[784]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::ClearQueue
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::stop
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:47:00 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::stPlaybackTimer
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::updateTrackBlock
Jun 30 13:47:00 volumio volumio[784]: info: CorePlayQueue::getTrackBlock
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:00 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:00 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:47:00 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::serviceStop
Jun 30 13:47:00 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:00 volumio volumio[784]: info: CoreCommandRouter::serviceStop
Jun 30 13:47:00 volumio volumio[784]: info: [1751291220314] ControllerWebradio::stop
Jun 30 13:47:00 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand stop
Jun 30 13:47:00 volumio volumio[784]: info: CorePlayQueue::clearPlayQueue
Jun 30 13:47:00 volumio volumio[784]: info: CorePlayQueue::saveQueue
Jun 30 13:47:00 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:00 volumio volumio[784]: info: CoreCommandRouter::volumioPushQueue
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::addQueueItems
Jun 30 13:47:00 volumio volumio[784]: info: CorePlayQueue::addQueueItems
Jun 30 13:47:00 volumio volumio[784]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99594606
Jun 30 13:47:00 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jun 30 13:47:00 volumio volumio[784]: info: CorePlayQueue::saveQueue
Jun 30 13:47:00 volumio volumio[784]: info: CoreCommandRouter::volumioPushQueue
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::updateTrackBlock
Jun 30 13:47:00 volumio volumio[784]: info: CorePlayQueue::getTrackBlock
Jun 30 13:47:00 volumio volumio[784]: info: CoreCommandRouter::volumioPlay
Jun 30 13:47:00 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::play index 0
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::stop
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:47:00 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::play index undefined
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:47:00 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::startPlaybackTimer
Jun 30 13:47:00 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:00 volumio volumio[784]: info: [1751291220331] ControllerWebradio::clearAddPlayTrack
Jun 30 13:47:00 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand stop
Jun 30 13:47:00 volumio volumio[784]: info:
Jun 30 13:47:00 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:47:00 volumio volumio[784]: info: sendMpdCommand stop took 22 milliseconds
Jun 30 13:47:00 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:47:00 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:47:00 volumio volumio[784]: info: sendMpdCommand stop took 6 milliseconds
Jun 30 13:47:00 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand clear
Jun 30 13:47:00 volumio volumio[784]: info:
Jun 30 13:47:00 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:47:00 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:47:00 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:47:00 volumio volumio[784]: info:
Jun 30 13:47:00 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:47:00 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:47:00 volumio volumio[784]: info: sendMpdCommand status took 3 milliseconds
Jun 30 13:47:00 volumio volumio[784]: info: sendMpdCommand clear took 3 milliseconds
Jun 30 13:47:00 volumio volumio[784]: info: sendMpdCommand status took 2 milliseconds
Jun 30 13:47:00 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:47:00 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:47:00 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99594606"
Jun 30 13:47:00 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:47:00 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:47:00 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:47:00 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:00 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:00 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:47:00 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:00 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:00 volumio volumio[784]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jun 30 13:47:00 volumio volumio[784]: info: ------------------------------ 10ms
Jun 30 13:47:00 volumio volumio[784]: info:
Jun 30 13:47:00 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:47:00 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:47:00 volumio volumio[784]: error: updateQueue error: null
Jun 30 13:47:00 volumio volumio[784]: info: ------------------------------ 10ms
Jun 30 13:47:00 volumio volumio[784]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jun 30 13:47:00 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:47:00 volumio volumio[784]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 30 13:47:00 volumio volumio[784]: info: ------------------------------ 14ms
Jun 30 13:47:02 volumio volumio[784]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99594606" took 2393 milliseconds
Jun 30 13:47:02 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 30 13:47:02 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand play
Jun 30 13:47:02 volumio volumio[784]: info:
Jun 30 13:47:02 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:47:02 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:47:02 volumio volumio[784]: info: ------------------------------ 2388ms
Jun 30 13:47:02 volumio volumio[784]: info:
Jun 30 13:47:02 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:47:02 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:47:02 volumio volumio[784]: Upnp client error: Error: This socket has been ended by the other party
Jun 30 13:47:02 volumio volumio[784]: info: sendMpdCommand play took 3 milliseconds
Jun 30 13:47:02 volumio volumio[784]: info: ------------------------------ 3ms
Jun 30 13:47:02 volumio volumio[784]: info: ------------------------------ 1ms
Jun 30 13:47:03 volumio volumio[784]: info:
Jun 30 13:47:03 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:47:03 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:47:03 volumio volumio[784]: info:
Jun 30 13:47:03 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:47:03 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:47:03 volumio volumio[784]: info:
Jun 30 13:47:03 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:47:03 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:47:03 volumio volumio[784]: info: sendMpdCommand status took 1 milliseconds
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:47:03 volumio volumio[784]: info:
Jun 30 13:47:03 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:47:03 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:47:03 volumio volumio[784]: info: sendMpdCommand status took 2 milliseconds
Jun 30 13:47:03 volumio volumio[784]: info: sendMpdCommand status took 2 milliseconds
Jun 30 13:47:03 volumio volumio[784]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:47:03 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:47:03 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:03 volumio volumio[784]: 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 - 93/1000) CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""}
Jun 30 13:47:03 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus stop
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:03 volumio volumio[784]: info: ------------------------------ 13ms
Jun 30 13:47:03 volumio volumio[784]: info: sendMpdCommand status took 10 milliseconds
Jun 30 13:47:03 volumio volumio[784]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jun 30 13:47:03 volumio volumio[784]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:47:03 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:47:03 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:03 volumio volumio[784]: 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 - 93/1000) CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""}
Jun 30 13:47:03 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:47:03 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:03 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:03 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:47:03 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:03 volumio volumio[784]: 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 - 93/1000) CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""}
Jun 30 13:47:03 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:47:03 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:03 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:03 volumio volumio[784]: info: ------------------------------ 39ms
Jun 30 13:47:03 volumio volumio[784]: info: ------------------------------ 39ms
Jun 30 13:47:03 volumio volumio[784]: info: sendMpdCommand playlistinfo took 33 milliseconds
Jun 30 13:47:03 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:47:03 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:47:03 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:03 volumio volumio[784]: 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 - 93/1000) CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""}
Jun 30 13:47:03 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:47:03 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:03 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:03 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:03 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:03 volumio volumio[784]: info: ------------------------------ 65ms
Jun 30 13:47:04 volumio volumio[784]: info:
Jun 30 13:47:04 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:47:04 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:47:04 volumio volumio[784]: info:
Jun 30 13:47:04 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:47:04 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:47:04 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:47:04 volumio volumio[784]: info:
Jun 30 13:47:04 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:47:04 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:47:04 volumio volumio[784]: info:
Jun 30 13:47:04 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:47:04 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:47:04 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:47:04 volumio volumio[784]: info: ------------------------------ 4ms
Jun 30 13:47:04 volumio volumio[784]: info: sendMpdCommand status took 3 milliseconds
Jun 30 13:47:04 volumio volumio[784]: info: ------------------------------ 2ms
Jun 30 13:47:04 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:47:04 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:47:04 volumio volumio[784]: info: sendMpdCommand status took 3 milliseconds
Jun 30 13:47:04 volumio volumio[784]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 30 13:47:04 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:47:04 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:47:04 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:47:04 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:47:04 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:47:04 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:04 volumio volumio[784]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Chris Botti - Good Morning Heartache","artist":"CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""}
Jun 30 13:47:04 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:47:04 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:47:04 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:47:04 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:47:04 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:47:04 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:04 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:47:04 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:04 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:04 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:04 volumio volumio[784]: info: ------------------------------ 19ms
Jun 30 13:47:04 volumio volumio[784]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jun 30 13:47:04 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:47:04 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:47:04 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:47:04 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:04 volumio volumio[784]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Chris Botti - Good Morning Heartache","artist":"CD 101.9 Smooth Jazz","album":null,"uri":"http://server.webnetradio.net:5334/stream","trackType":""}
Jun 30 13:47:04 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:47:04 volumio volumio[784]: info: CoreStateMachine::syncState stateService play
Jun 30 13:47:04 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus play
Jun 30 13:47:04 volumio volumio[784]: info: Received an update from plugin. extracting info from payload
Jun 30 13:47:04 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 30 13:47:04 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:04 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:04 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:04 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:04 volumio volumio[784]: info: ------------------------------ 29ms
Jun 30 13:47:06 volumio volumio[784]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/(%231%20-%2093%2F1000)%20CD%20101.9%20Smooth%20Jazz/b6478181-be48-4180-b233-20c166b1c961.jpg'
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::ClearQueue
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::stop
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:47:23 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::stPlaybackTimer
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::updateTrackBlock
Jun 30 13:47:23 volumio volumio[784]: info: CorePlayQueue::getTrackBlock
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:23 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::serviceStop
Jun 30 13:47:23 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::serviceStop
Jun 30 13:47:23 volumio volumio[784]: info: [1751291243262] ControllerWebradio::stop
Jun 30 13:47:23 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand stop
Jun 30 13:47:23 volumio volumio[784]: info: CorePlayQueue::clearPlayQueue
Jun 30 13:47:23 volumio volumio[784]: info: CorePlayQueue::saveQueue
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::volumioPushQueue
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::addQueueItems
Jun 30 13:47:23 volumio volumio[784]: info: CorePlayQueue::addQueueItems
Jun 30 13:47:23 volumio volumio[784]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99607662
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jun 30 13:47:23 volumio volumio[784]: info: CorePlayQueue::saveQueue
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::volumioPushQueue
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::updateTrackBlock
Jun 30 13:47:23 volumio volumio[784]: info: CorePlayQueue::getTrackBlock
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::volumioPlay
Jun 30 13:47:23 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::play index 0
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::stop
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:47:23 volumio volumio[784]: verbose: UNSET VOLATILE
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::play index undefined
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 30 13:47:23 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::startPlaybackTimer
Jun 30 13:47:23 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:23 volumio volumio[784]: info: [1751291243281] ControllerWebradio::clearAddPlayTrack
Jun 30 13:47:23 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand stop
Jun 30 13:47:23 volumio volumio[784]: info:
Jun 30 13:47:23 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:47:23 volumio volumio[784]: info: sendMpdCommand stop took 23 milliseconds
Jun 30 13:47:23 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:47:23 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:47:23 volumio volumio[784]: info: sendMpdCommand stop took 5 milliseconds
Jun 30 13:47:23 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand clear
Jun 30 13:47:23 volumio volumio[784]: info:
Jun 30 13:47:23 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:47:23 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:47:23 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:47:23 volumio volumio[784]: info:
Jun 30 13:47:23 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:47:23 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:47:23 volumio volumio[784]: info: sendMpdCommand status took 4 milliseconds
Jun 30 13:47:23 volumio volumio[784]: info: sendMpdCommand clear took 4 milliseconds
Jun 30 13:47:23 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:47:23 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:47:23 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99607662"
Jun 30 13:47:23 volumio volumio[784]: info:
Jun 30 13:47:23 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:47:23 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:47:23 volumio volumio[784]: error: updateQueue error: null
Jun 30 13:47:23 volumio volumio[784]: info:
Jun 30 13:47:23 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:47:23 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:47:23 volumio volumio[784]: info: sendMpdCommand status took 249 milliseconds
Jun 30 13:47:23 volumio volumio[784]: info: ------------------------------ 249ms
Jun 30 13:47:23 volumio volumio[784]: info: sendMpdCommand playlistinfo took 248 milliseconds
Jun 30 13:47:23 volumio volumio[784]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99607662" took 248 milliseconds
Jun 30 13:47:23 volumio volumio[784]: info: ------------------------------ 247ms
Jun 30 13:47:23 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:47:23 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 30 13:47:23 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand play
Jun 30 13:47:23 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:23 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:23 volumio volumio[784]: 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}
Jun 30 13:47:23 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::syncState stateService stop
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus stop
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:23 volumio volumio[784]: info: No code
Jun 30 13:47:23 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:23 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:23 volumio volumio[784]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 30 13:47:23 volumio volumio[784]: info: ------------------------------ 274ms
Jun 30 13:47:23 volumio volumio[784]: info: ------------------------------ 276ms
Jun 30 13:47:23 volumio volumio[784]: info:
Jun 30 13:47:23 volumio volumio[784]: ---------------------------- MPD announces system playlist update
Jun 30 13:47:23 volumio volumio[784]: info: Ignoring MPD Status Update
Jun 30 13:47:23 volumio volumio[784]: info: ------------------------------ 25ms
Jun 30 13:47:23 volumio volumio[784]: info: sendMpdCommand play took 23 milliseconds
Jun 30 13:47:23 volumio volumio[784]: info: ------------------------------ 2ms
Jun 30 13:47:24 volumio volumio[784]: info:
Jun 30 13:47:24 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:47:24 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:47:24 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:47:24 volumio volumio[784]: info:
Jun 30 13:47:24 volumio volumio[784]: ---------------------------- MPD announces state update: player
Jun 30 13:47:24 volumio volumio[784]: info: ControllerMpd::getState
Jun 30 13:47:24 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand status
Jun 30 13:47:24 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand clearerror
Jun 30 13:47:24 volumio volumio[784]: info: sendMpdCommand status took 4 milliseconds
Jun 30 13:47:24 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand clearerror
Jun 30 13:47:24 volumio volumio[784]: info: sendMpdCommand status took 4 milliseconds
Jun 30 13:47:24 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:47:24 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:47:24 volumio volumio[784]: verbose: ControllerMpd::parseState
Jun 30 13:47:24 volumio volumio[784]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 30 13:47:24 volumio volumio[784]: info: sendMpdCommand clearerror took 5 milliseconds
Jun 30 13:47:24 volumio volumio[784]: info: sendMpdCommand clearerror took 4 milliseconds
Jun 30 13:47:24 volumio volumio[784]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 30 13:47:24 volumio volumio[784]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jun 30 13:47:24 volumio volumio[784]: verbose: ControllerMpd::parseTrackInfo
Jun 30 13:47:24 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:47:24 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:47:24 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:24 volumio volumio[784]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 13:47:24 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:24 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:24 volumio volumio[784]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 80/400) HIT RADIO MANELE ROMANIA","album":null,"uri":"https://94.23.70.105:8050/stream","trackType":""}
Jun 30 13:47:24 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:47:24 volumio volumio[784]: info: CoreStateMachine::syncState stateService stop
Jun 30 13:47:24 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus stop
Jun 30 13:47:24 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:24 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:24 volumio volumio[784]: info: No code
Jun 30 13:47:24 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:24 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:24 volumio volumio[784]: info: ControllerMpd::pushState
Jun 30 13:47:24 volumio volumio[784]: info: CoreCommandRouter::servicePushState
Jun 30 13:47:24 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:24 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:24 volumio volumio[784]: info: CorePlayQueue::getTrack 0
Jun 30 13:47:24 volumio volumio[784]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 80/400) HIT RADIO MANELE ROMANIA","album":null,"uri":"https://94.23.70.105:8050/stream","trackType":""}
Jun 30 13:47:24 volumio volumio[784]: verbose: CURRENT POSITION 0
Jun 30 13:47:24 volumio volumio[784]: info: CoreStateMachine::syncState stateService stop
Jun 30 13:47:24 volumio volumio[784]: info: CoreStateMachine::syncState currentStatus stop
Jun 30 13:47:24 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:24 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:24 volumio volumio[784]: info: No code
Jun 30 13:47:24 volumio volumio[784]: info: CoreStateMachine::pushState
Jun 30 13:47:24 volumio volumio[784]: info: CoreCommandRouter::volumioPushState
Jun 30 13:47:24 volumio volumio[784]: info: ------------------------------ 40ms
Jun 30 13:47:24 volumio volumio[784]: info: ------------------------------ 40ms
Jun 30 13:47:35 volumio volumio[784]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 13:47:35 volumio volumio[784]: Error: connect ETIMEDOUT 185.60.219.36:80
Jun 30 13:47:35 volumio volumio[784]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Jun 30 13:47:35 volumio volumio[784]: errno: -110,
Jun 30 13:47:35 volumio volumio[784]: code: 'ETIMEDOUT',
Jun 30 13:47:35 volumio volumio[784]: syscall: 'connect',
Jun 30 13:47:35 volumio volumio[784]: address: '185.60.219.36',
Jun 30 13:47:35 volumio volumio[784]: port: 80
Jun 30 13:47:35 volumio volumio[784]: }
Jun 30 13:47:35 volumio volumio[784]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 13:47:35 volumio sudo[4243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 13:46
Jun 30 13:47:35 volumio sudo[4243]: 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="1c5fa5a8788b087ca429be9d10851b25c5cc4f5b"
VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9"
VOLUMIO_FE3_VERSION="a86adf3c7ed2d6c50d9bca768f58ab2f56832dc1"
VOLUMIO_BE_VERSION="c8882d89d3d4e0a1571e0dc9701741128f5a1656"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 31 Mar 2022 03:20:44 PM CEST"
VOLUMIO_VERSION="3.251"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="e524350c1f6dfee48683e2ce9db25952"