-- Logs begin at Thu 2025-02-20 22:07:50 CST, end at Thu 2025-02-20 22:13:48 CST. -- Feb 20 22:12:00 volumio volumio[793]: info: Preload queue cleared Feb 20 22:12:20 volumio volumio[793]: info: Preload queue cleared Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::ClearQueue Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::stop Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::stPlaybackTimer Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::updateTrackBlock Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::getTrackBlock Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::serviceStop Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::serviceStop Feb 20 22:12:20 volumio volumio[793]: info: [1740060740047] ControllerWebradio::stop Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::clearPlayQueue Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::saveQueue Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioPushQueue Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::addQueueItems Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::addQueueItems Feb 20 22:12:20 volumio volumio[793]: info: Preload queue cleared Feb 20 22:12:20 volumio volumio[793]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99441647 Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioPushQueue Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::saveQueue Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::updateTrackBlock Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::getTrackBlock Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioPlay Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::play index 0 Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::stop Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::play index undefined Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::startPlaybackTimer Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:20 volumio volumio[793]: info: [1740060740077] ControllerWebradio::clearAddPlayTrack Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 22:12:20 volumio volumio[793]: info: Feb 20 22:12:20 volumio volumio[793]: ---------------------------- MPD announces state update: player Feb 20 22:12:20 volumio volumio[793]: info: sendMpdCommand stop took 35 milliseconds Feb 20 22:12:20 volumio volumio[793]: info: ControllerMpd::getState Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand status Feb 20 22:12:20 volumio volumio[793]: info: sendMpdCommand stop took 7 milliseconds Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 22:12:20 volumio volumio[793]: info: Feb 20 22:12:20 volumio volumio[793]: ---------------------------- MPD announces system playlist update Feb 20 22:12:20 volumio volumio[793]: info: Ignoring MPD Status Update Feb 20 22:12:20 volumio volumio[793]: info: sendMpdCommand status took 2 milliseconds Feb 20 22:12:20 volumio volumio[793]: info: sendMpdCommand clear took 2 milliseconds Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::parseState Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99441647" Feb 20 22:12:20 volumio volumio[793]: error: updateQueue error: null Feb 20 22:12:20 volumio volumio[793]: info: ------------------------------ 4ms Feb 20 22:12:20 volumio volumio[793]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::parseTrackInfo Feb 20 22:12:20 volumio volumio[793]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 20 22:12:20 volumio volumio[793]: info: ------------------------------ 8ms Feb 20 22:12:20 volumio volumio[793]: info: Preload queue cleared Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::ClearQueue Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::stop Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::clearPlayQueue Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::saveQueue Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioPushQueue Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::addQueueItems Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::addQueueItems Feb 20 22:12:20 volumio volumio[793]: info: Preload queue cleared Feb 20 22:12:20 volumio volumio[793]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99441647 Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioPushQueue Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::saveQueue Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::updateTrackBlock Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::getTrackBlock Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioPlay Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::play index 0 Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::stop Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::play index undefined Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::startPlaybackTimer Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:20 volumio volumio[793]: info: [1740060740520] ControllerWebradio::clearAddPlayTrack Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 22:12:20 volumio volumio[793]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99441647" took 468 milliseconds Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand play Feb 20 22:12:20 volumio volumio[793]: info: Feb 20 22:12:20 volumio volumio[793]: ---------------------------- MPD announces system playlist update Feb 20 22:12:20 volumio volumio[793]: info: Ignoring MPD Status Update Feb 20 22:12:20 volumio volumio[793]: info: sendMpdCommand stop took 37 milliseconds Feb 20 22:12:20 volumio volumio[793]: info: sendMpdCommand play took 1 milliseconds Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 22:12:20 volumio volumio[793]: info: ------------------------------ 3ms Feb 20 22:12:20 volumio volumio[793]: info: Preload queue cleared Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::ClearQueue Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::stop Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::clearPlayQueue Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::saveQueue Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioPushQueue Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::addQueueItems Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::addQueueItems Feb 20 22:12:20 volumio volumio[793]: info: Preload queue cleared Feb 20 22:12:20 volumio volumio[793]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99441647 Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioPushQueue Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::saveQueue Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::updateTrackBlock Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::getTrackBlock Feb 20 22:12:20 volumio volumio[793]: info: CoreCommandRouter::volumioPlay Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::play index 0 Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::stop Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::play index undefined Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:20 volumio volumio[793]: info: CoreStateMachine::startPlaybackTimer Feb 20 22:12:20 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:20 volumio volumio[793]: info: [1740060740750] ControllerWebradio::clearAddPlayTrack Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand stop Feb 20 22:12:20 volumio volumio[793]: info: sendMpdCommand clear took 431 milliseconds Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99441647" Feb 20 22:12:20 volumio volumio[793]: info: Feb 20 22:12:20 volumio volumio[793]: ---------------------------- MPD announces system playlist update Feb 20 22:12:20 volumio volumio[793]: info: Ignoring MPD Status Update Feb 20 22:12:20 volumio volumio[793]: info: Feb 20 22:12:20 volumio volumio[793]: ---------------------------- MPD announces state update: player Feb 20 22:12:20 volumio volumio[793]: info: ControllerMpd::getState Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand status Feb 20 22:12:20 volumio volumio[793]: info: sendMpdCommand stop took 241 milliseconds Feb 20 22:12:20 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand clear Feb 20 22:12:21 volumio volumio[793]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99441647" took 234 milliseconds Feb 20 22:12:21 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 22:12:21 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand play Feb 20 22:12:21 volumio volumio[793]: info: Feb 20 22:12:21 volumio volumio[793]: ---------------------------- MPD announces system playlist update Feb 20 22:12:21 volumio volumio[793]: info: Ignoring MPD Status Update Feb 20 22:12:21 volumio volumio[793]: info: Feb 20 22:12:21 volumio volumio[793]: ---------------------------- MPD announces system playlist update Feb 20 22:12:21 volumio volumio[793]: info: Ignoring MPD Status Update Feb 20 22:12:21 volumio volumio[793]: info: ------------------------------ 236ms Feb 20 22:12:21 volumio volumio[793]: info: sendMpdCommand status took 236 milliseconds Feb 20 22:12:21 volumio volumio[793]: info: sendMpdCommand clear took 235 milliseconds Feb 20 22:12:21 volumio volumio[793]: verbose: ControllerMpd::parseState Feb 20 22:12:21 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99441647" Feb 20 22:12:21 volumio volumio[793]: info: ControllerMpd::pushState Feb 20 22:12:21 volumio volumio[793]: info: CoreCommandRouter::servicePushState Feb 20 22:12:21 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:12:21 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 22:12:21 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:12:21 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:21 volumio volumio[793]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 20 22:12:21 volumio volumio[793]: verbose: CURRENT POSITION 0 Feb 20 22:12:21 volumio volumio[793]: info: CoreStateMachine::syncState stateService stop Feb 20 22:12:21 volumio volumio[793]: info: CoreStateMachine::syncState currentStatus stop Feb 20 22:12:21 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:12:21 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:12:21 volumio volumio[793]: info: No code Feb 20 22:12:21 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:12:21 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:12:21 volumio volumio[793]: info: ------------------------------ 262ms Feb 20 22:12:21 volumio volumio[793]: error: updateQueue error: null Feb 20 22:12:21 volumio volumio[793]: error: updateQueue error: null Feb 20 22:12:21 volumio volumio[793]: info: sendMpdCommand play took 30 milliseconds Feb 20 22:12:21 volumio volumio[793]: info: ------------------------------ 30ms Feb 20 22:12:21 volumio volumio[793]: info: ------------------------------ 29ms Feb 20 22:12:21 volumio volumio[793]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99441647" took 244 milliseconds Feb 20 22:12:21 volumio volumio[793]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 20 22:12:21 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand play Feb 20 22:12:21 volumio volumio[793]: info: Feb 20 22:12:21 volumio volumio[793]: ---------------------------- MPD announces system playlist update Feb 20 22:12:21 volumio volumio[793]: info: Ignoring MPD Status Update Feb 20 22:12:21 volumio volumio[793]: info: sendMpdCommand play took 1 milliseconds Feb 20 22:12:21 volumio volumio[793]: info: ------------------------------ 2ms Feb 20 22:12:22 volumio volumio[793]: info: Feb 20 22:12:22 volumio volumio[793]: ---------------------------- MPD announces state update: player Feb 20 22:12:22 volumio volumio[793]: info: ControllerMpd::getState Feb 20 22:12:22 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand status Feb 20 22:12:22 volumio volumio[793]: info: Feb 20 22:12:22 volumio volumio[793]: ---------------------------- MPD announces state update: player Feb 20 22:12:22 volumio volumio[793]: info: ControllerMpd::getState Feb 20 22:12:22 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand status Feb 20 22:12:22 volumio volumio[793]: info: sendMpdCommand status took 2 milliseconds Feb 20 22:12:22 volumio volumio[793]: verbose: ControllerMpd::parseState Feb 20 22:12:22 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 22:12:22 volumio volumio[793]: info: sendMpdCommand status took 2 milliseconds Feb 20 22:12:22 volumio volumio[793]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 20 22:12:22 volumio volumio[793]: verbose: ControllerMpd::parseState Feb 20 22:12:22 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 22:12:22 volumio volumio[793]: verbose: ControllerMpd::parseTrackInfo Feb 20 22:12:22 volumio volumio[793]: info: ControllerMpd::pushState Feb 20 22:12:22 volumio volumio[793]: info: CoreCommandRouter::servicePushState Feb 20 22:12:22 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:22 volumio volumio[793]: 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 - 543/2000) Blues Radio","album":null,"uri":"https://i4.streams.ovh:8352/stream","trackType":""} Feb 20 22:12:22 volumio volumio[793]: verbose: CURRENT POSITION 0 Feb 20 22:12:22 volumio volumio[793]: info: CoreStateMachine::syncState stateService play Feb 20 22:12:22 volumio volumio[793]: info: CoreStateMachine::syncState currentStatus stop Feb 20 22:12:22 volumio volumio[793]: info: ------------------------------ 7ms Feb 20 22:12:22 volumio volumio[793]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 20 22:12:22 volumio volumio[793]: verbose: ControllerMpd::parseTrackInfo Feb 20 22:12:22 volumio volumio[793]: info: ControllerMpd::pushState Feb 20 22:12:22 volumio volumio[793]: info: CoreCommandRouter::servicePushState Feb 20 22:12:22 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:22 volumio volumio[793]: 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 - 543/2000) Blues Radio","album":null,"uri":"https://i4.streams.ovh:8352/stream","trackType":""} Feb 20 22:12:22 volumio volumio[793]: verbose: CURRENT POSITION 0 Feb 20 22:12:22 volumio volumio[793]: info: CoreStateMachine::syncState stateService play Feb 20 22:12:22 volumio volumio[793]: info: CoreStateMachine::syncState currentStatus play Feb 20 22:12:22 volumio volumio[793]: info: Received an update from plugin. extracting info from payload Feb 20 22:12:22 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 20 22:12:22 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:12:22 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:22 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 22:12:22 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:12:22 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:12:22 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:12:22 volumio volumio[793]: info: ------------------------------ 24ms Feb 20 22:12:23 volumio volumio[793]: info: Feb 20 22:12:23 volumio volumio[793]: ---------------------------- MPD announces system playlist update Feb 20 22:12:23 volumio volumio[793]: info: Ignoring MPD Status Update Feb 20 22:12:23 volumio volumio[793]: info: Feb 20 22:12:23 volumio volumio[793]: ---------------------------- MPD announces state update: player Feb 20 22:12:23 volumio volumio[793]: info: ControllerMpd::getState Feb 20 22:12:23 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand status Feb 20 22:12:23 volumio volumio[793]: info: ------------------------------ 2ms Feb 20 22:12:23 volumio volumio[793]: info: sendMpdCommand status took 2 milliseconds Feb 20 22:12:23 volumio volumio[793]: verbose: ControllerMpd::parseState Feb 20 22:12:23 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 22:12:23 volumio volumio[793]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 20 22:12:23 volumio volumio[793]: verbose: ControllerMpd::parseTrackInfo Feb 20 22:12:23 volumio volumio[793]: info: ControllerMpd::pushState Feb 20 22:12:23 volumio volumio[793]: info: CoreCommandRouter::servicePushState Feb 20 22:12:23 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:23 volumio volumio[793]: 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":"320 Kbps","isStreaming":false,"title":"Hangin' Judge - Devil Woman","artist":"Blues Radio","album":null,"uri":"https://i4.streams.ovh:8352/stream","trackType":""} Feb 20 22:12:23 volumio volumio[793]: verbose: CURRENT POSITION 0 Feb 20 22:12:23 volumio volumio[793]: info: CoreStateMachine::syncState stateService play Feb 20 22:12:23 volumio volumio[793]: info: CoreStateMachine::syncState currentStatus play Feb 20 22:12:23 volumio volumio[793]: info: Received an update from plugin. extracting info from payload Feb 20 22:12:23 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 20 22:12:23 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:12:23 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 22:12:23 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:12:23 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:12:23 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:12:23 volumio volumio[793]: info: ------------------------------ 20ms Feb 20 22:12:23 volumio volumio[793]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Blues%20Radio/6a2cfb76-22b2-4413-9eaa-567653718a6f.jpg' Feb 20 22:12:34 volumio volumio[793]: info: Feb 20 22:12:34 volumio volumio[793]: ---------------------------- MPD announces system playlist update Feb 20 22:12:34 volumio volumio[793]: info: Ignoring MPD Status Update Feb 20 22:12:34 volumio volumio[793]: info: Feb 20 22:12:34 volumio volumio[793]: ---------------------------- MPD announces state update: player Feb 20 22:12:34 volumio volumio[793]: info: ControllerMpd::getState Feb 20 22:12:34 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand status Feb 20 22:12:34 volumio volumio[793]: info: ------------------------------ 2ms Feb 20 22:12:34 volumio volumio[793]: info: sendMpdCommand status took 1 milliseconds Feb 20 22:12:34 volumio volumio[793]: verbose: ControllerMpd::parseState Feb 20 22:12:34 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 22:12:34 volumio volumio[793]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 20 22:12:34 volumio volumio[793]: verbose: ControllerMpd::parseTrackInfo Feb 20 22:12:34 volumio volumio[793]: info: ControllerMpd::pushState Feb 20 22:12:34 volumio volumio[793]: info: CoreCommandRouter::servicePushState Feb 20 22:12:34 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:12:34 volumio volumio[793]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12488,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Lamont Cranston Band - As The Years Go Passin' By","artist":"Blues Radio","album":null,"uri":"https://i4.streams.ovh:8352/stream","trackType":""} Feb 20 22:12:34 volumio volumio[793]: verbose: CURRENT POSITION 0 Feb 20 22:12:34 volumio volumio[793]: info: CoreStateMachine::syncState stateService play Feb 20 22:12:34 volumio volumio[793]: info: CoreStateMachine::syncState currentStatus play Feb 20 22:12:34 volumio volumio[793]: info: Received an update from plugin. extracting info from payload Feb 20 22:12:34 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 20 22:12:34 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:12:34 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 22:12:34 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:12:34 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:12:34 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:12:34 volumio volumio[793]: info: ------------------------------ 21ms Feb 20 22:12:51 volumio volumio[793]: info: VolumeController::SetAlsaVolume85 Feb 20 22:12:51 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:12:51 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 22:12:51 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:13:01 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 20 22:13:01 volumio volumio[793]: info: TuneIn handleBrowseUri: tunein/popular Feb 20 22:13:15 volumio volumio[793]: info: CoreCommandRouter::volumioGetState Feb 20 22:13:36 volumio kernel: usb 1-4.1: new high-speed USB device number 8 using xhci_hcd Feb 20 22:13:36 volumio kernel: usb 1-4.1: New USB device found, idVendor=152d, idProduct=0580, bcdDevice= 2.15 Feb 20 22:13:36 volumio kernel: usb 1-4.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Feb 20 22:13:36 volumio kernel: usb 1-4.1: Product: External Feb 20 22:13:36 volumio kernel: usb 1-4.1: Manufacturer: Generic Feb 20 22:13:36 volumio kernel: usb 1-4.1: SerialNumber: DD5641988389E Feb 20 22:13:36 volumio kernel: scsi host3: uas Feb 20 22:13:36 volumio kernel: scsi 3:0:0:0: Direct-Access JMicron 0215 PQ: 0 ANSI: 6 Feb 20 22:13:36 volumio kernel: scsi 3:0:0:0: Attached scsi generic sg2 type 0 Feb 20 22:13:36 volumio kernel: sd 3:0:0:0: [sdc] 1000215216 512-byte logical blocks: (512 GB/477 GiB) Feb 20 22:13:36 volumio kernel: sd 3:0:0:0: [sdc] 4096-byte physical blocks Feb 20 22:13:36 volumio kernel: sd 3:0:0:0: [sdc] Write Protect is off Feb 20 22:13:36 volumio kernel: sd 3:0:0:0: [sdc] Mode Sense: 5f 00 00 08 Feb 20 22:13:36 volumio kernel: sd 3:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Feb 20 22:13:36 volumio kernel: sd 3:0:0:0: [sdc] Optimal transfer size 33553920 bytes not a multiple of physical block size (4096 bytes) Feb 20 22:13:36 volumio kernel: sdc: sdc1 Feb 20 22:13:36 volumio kernel: sd 3:0:0:0: [sdc] Attached SCSI disk Feb 20 22:13:37 volumio volumio[793]: info: Mounting Device 0FC217730FC21773 Feb 20 22:13:37 volumio sudo[1815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc1 /mnt/USB/0FC217730FC21773 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 20 22:13:37 volumio sudo[1815]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 20 22:13:37 volumio ntfs-3g[1818]: Version 2017.3.23AR.3 integrated FUSE 28 Feb 20 22:13:37 volumio ntfs-3g[1818]: Mounted /dev/sdc1 (Read-Write, label "", NTFS 3.1) Feb 20 22:13:37 volumio ntfs-3g[1818]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 20 22:13:37 volumio ntfs-3g[1818]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdc1,blkdev,blksize=4096 Feb 20 22:13:37 volumio ntfs-3g[1818]: Global ownership and permissions enforced, configuration type 7 Feb 20 22:13:37 volumio sudo[1815]: pam_unix(sudo:session): session closed for user root Feb 20 22:13:37 volumio volumio[793]: info: Scanning new location : "USB/0FC217730FC21773" Feb 20 22:13:37 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand status Feb 20 22:13:37 volumio volumio[793]: info: Feb 20 22:13:37 volumio volumio[793]: ---------------------------- MPD announces state update: update Feb 20 22:13:37 volumio volumio[793]: info: ControllerMpd::getState Feb 20 22:13:37 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand status Feb 20 22:13:37 volumio volumio[793]: info: sendMpdCommand status took 3 milliseconds Feb 20 22:13:37 volumio volumio[793]: info: sendMpdCommand status took 1 milliseconds Feb 20 22:13:37 volumio volumio[793]: verbose: ControllerMpd::parseState Feb 20 22:13:41 volumio volumio[793]: info: Command Router : Notfying DB Updatetrue Feb 20 22:13:41 volumio volumio[793]: verbose: ControllerMpd::parseState Feb 20 22:13:41 volumio volumio[793]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 20 22:13:41 volumio volumio[793]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 20 22:13:41 volumio volumio[793]: verbose: ControllerMpd::parseTrackInfo Feb 20 22:13:41 volumio volumio[793]: info: ControllerMpd::pushState Feb 20 22:13:41 volumio volumio[793]: info: CoreCommandRouter::servicePushState Feb 20 22:13:41 volumio volumio[793]: info: CorePlayQueue::getTrack 0 Feb 20 22:13:41 volumio volumio[793]: verbose: STATE SERVICE {"status":"play","position":0,"seek":75387,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Lamont Cranston Band - As The Years Go Passin' By","artist":"Blues Radio","album":null,"uri":"https://i4.streams.ovh:8352/stream","trackType":""} Feb 20 22:13:41 volumio volumio[793]: verbose: CURRENT POSITION 0 Feb 20 22:13:41 volumio volumio[793]: info: CoreStateMachine::syncState stateService play Feb 20 22:13:41 volumio volumio[793]: info: CoreStateMachine::syncState currentStatus play Feb 20 22:13:41 volumio volumio[793]: info: Received an update from plugin. extracting info from payload Feb 20 22:13:41 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 20 22:13:41 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:13:41 volumio volumio[793]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 20 22:13:41 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:13:41 volumio volumio[793]: info: CoreStateMachine::pushState Feb 20 22:13:41 volumio volumio[793]: info: CoreCommandRouter::volumioPushState Feb 20 22:13:41 volumio volumio[793]: info: ------------------------------ 3642ms Feb 20 22:13:48 volumio volumio[793]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 20 22:13:48 volumio volumio[793]: Error: connect ETIMEDOUT 31.13.90.19:80 Feb 20 22:13:48 volumio volumio[793]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 20 22:13:48 volumio volumio[793]: errno: -110, Feb 20 22:13:48 volumio volumio[793]: code: 'ETIMEDOUT', Feb 20 22:13:48 volumio volumio[793]: syscall: 'connect', Feb 20 22:13:48 volumio volumio[793]: address: '31.13.90.19', Feb 20 22:13:48 volumio volumio[793]: port: 80 Feb 20 22:13:48 volumio volumio[793]: } Feb 20 22:13:48 volumio volumio[793]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 20 22:13:48 volumio sudo[1835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-20 22:12 Feb 20 22:13:48 volumio sudo[1835]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 06:04:32 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="dd58c1c2d5a97e584de8089531ce548f"