-- Logs begin at Thu 2019-02-14 13:11:58 MSK, end at Fri 2025-09-12 22:15:50 MSK. --
Sep 12 22:14:03 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:03 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 12 22:14:03 volumio volumio[994]: info: CoreStateMachine::ClearQueue
Sep 12 22:14:03 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:03 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:03 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue
Sep 12 22:14:03 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:03 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:03 volumio volumio[994]: info: CoreStateMachine::addQueueItems
Sep 12 22:14:03 volumio volumio[994]: info: CorePlayQueue::addQueueItems
Sep 12 22:14:03 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:03 volumio volumio[994]: info: Adding Item to queue: webeighties/2
Sep 12 22:14:03 volumio volumio[994]: info: Exploding uri webeighties/2 in service 80s80s
Sep 12 22:14:03 volumio volumio[994]: info: [1757704443170] [80s80s] explodeUri: webeighties/2
Sep 12 22:14:03 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:03 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:03 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock
Sep 12 22:14:03 volumio volumio[994]: info: CorePlayQueue::getTrackBlock
Sep 12 22:14:03 volumio volumio[994]: info: CoreCommandRouter::volumioPlay
Sep 12 22:14:03 volumio volumio[994]: info: CoreStateMachine::play index 0
Sep 12 22:14:03 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:03 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:03 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:03 volumio volumio[994]: info: CoreStateMachine::play index undefined
Sep 12 22:14:03 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:03 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:03 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer
Sep 12 22:14:03 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:03 volumio volumio[994]: info: [1757704443177] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/love/mp3-192/volumio
Sep 12 22:14:03 volumio volumio[994]: info: [1757704443177] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=85&count=2
Sep 12 22:14:03 volumio volumio[994]: info: [1757704443434] [80s80s] received new event containing 2 songs.
Sep 12 22:14:03 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop
Sep 12 22:14:10 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:10 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 12 22:14:10 volumio volumio[994]: info: CoreStateMachine::ClearQueue
Sep 12 22:14:10 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:10 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:10 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue
Sep 12 22:14:10 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:10 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:10 volumio volumio[994]: info: CoreStateMachine::addQueueItems
Sep 12 22:14:10 volumio volumio[994]: info: CorePlayQueue::addQueueItems
Sep 12 22:14:10 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:10 volumio volumio[994]: info: Adding Item to queue: webeighties/11
Sep 12 22:14:10 volumio volumio[994]: info: Exploding uri webeighties/11 in service 80s80s
Sep 12 22:14:10 volumio volumio[994]: info: [1757704450087] [80s80s] explodeUri: webeighties/11
Sep 12 22:14:10 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:10 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:10 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock
Sep 12 22:14:10 volumio volumio[994]: info: CorePlayQueue::getTrackBlock
Sep 12 22:14:10 volumio volumio[994]: info: CoreCommandRouter::volumioPlay
Sep 12 22:14:10 volumio volumio[994]: info: CoreStateMachine::play index 0
Sep 12 22:14:10 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:10 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:10 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:10 volumio volumio[994]: info: CoreStateMachine::play index undefined
Sep 12 22:14:10 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:10 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:10 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer
Sep 12 22:14:10 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:10 volumio volumio[994]: info: [1757704450096] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/hamburg/mp3-192/volumio
Sep 12 22:14:10 volumio volumio[994]: info: [1757704450096] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=61&count=2
Sep 12 22:14:10 volumio volumio[994]: info: [1757704450334] [80s80s] received new event containing 2 songs.
Sep 12 22:14:10 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop
Sep 12 22:14:14 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:14 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 12 22:14:14 volumio volumio[994]: info: CoreStateMachine::ClearQueue
Sep 12 22:14:14 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:14 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:14 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue
Sep 12 22:14:14 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:14 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:14 volumio volumio[994]: info: CoreStateMachine::addQueueItems
Sep 12 22:14:14 volumio volumio[994]: info: CorePlayQueue::addQueueItems
Sep 12 22:14:14 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:14 volumio volumio[994]: info: Adding Item to queue: webeighties/10
Sep 12 22:14:14 volumio volumio[994]: info: Exploding uri webeighties/10 in service 80s80s
Sep 12 22:14:14 volumio volumio[994]: info: [1757704454750] [80s80s] explodeUri: webeighties/10
Sep 12 22:14:14 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:14 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:14 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock
Sep 12 22:14:14 volumio volumio[994]: info: CorePlayQueue::getTrackBlock
Sep 12 22:14:14 volumio volumio[994]: info: CoreCommandRouter::volumioPlay
Sep 12 22:14:14 volumio volumio[994]: info: CoreStateMachine::play index 0
Sep 12 22:14:14 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:14 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:14 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:14 volumio volumio[994]: info: CoreStateMachine::play index undefined
Sep 12 22:14:14 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:14 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:14 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer
Sep 12 22:14:14 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:14 volumio volumio[994]: info: [1757704454757] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/christmas/mp3-192/volumio
Sep 12 22:14:14 volumio volumio[994]: info: [1757704454757] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=75&count=2
Sep 12 22:14:15 volumio volumio[994]: info: [1757704455010] [80s80s] received new event containing 2 songs.
Sep 12 22:14:15 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop
Sep 12 22:14:18 volumio mpd_monitor.sh[625]: MPD Monitor Service: MPD Appears to be inactive, restarting
Sep 12 22:14:18 volumio systemd[1]: Stopping Music Player Daemon...
Sep 12 22:14:21 volumio volumio[994]: info: CoreCommandRouter::volumioGetState
Sep 12 22:14:21 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:26 volumio volumio[994]: info: CoreCommandRouter::volumioPlay
Sep 12 22:14:26 volumio volumio[994]: info: CoreStateMachine::play index undefined
Sep 12 22:14:26 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:26 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:26 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer
Sep 12 22:14:26 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:26 volumio volumio[994]: info: [1757704466926] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/christmas/mp3-192/volumio
Sep 12 22:14:26 volumio volumio[994]: info: [1757704466926] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=75&count=2
Sep 12 22:14:27 volumio volumio[994]: info: [1757704467156] [80s80s] received new event containing 2 songs.
Sep 12 22:14:27 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop
Sep 12 22:14:32 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri
Sep 12 22:14:32 volumio volumio[994]: info: [1757704472818] [80s80s] handleBrowseUri curUri: 80s80s/nineties
Sep 12 22:14:32 volumio volumio[994]: info: [1757704472818] [80s80s] getRadioContent url: nineties
Sep 12 22:14:32 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:34 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:34 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 12 22:14:34 volumio volumio[994]: info: CoreStateMachine::ClearQueue
Sep 12 22:14:34 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:34 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:34 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue
Sep 12 22:14:34 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:34 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:34 volumio volumio[994]: info: CoreStateMachine::addQueueItems
Sep 12 22:14:34 volumio volumio[994]: info: CorePlayQueue::addQueueItems
Sep 12 22:14:34 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:34 volumio volumio[994]: info: Adding Item to queue: webnineties/1
Sep 12 22:14:34 volumio volumio[994]: info: Exploding uri webnineties/1 in service 80s80s
Sep 12 22:14:34 volumio volumio[994]: info: [1757704474312] [80s80s] explodeUri: webnineties/1
Sep 12 22:14:34 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:34 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:34 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock
Sep 12 22:14:34 volumio volumio[994]: info: CorePlayQueue::getTrackBlock
Sep 12 22:14:34 volumio volumio[994]: info: CoreCommandRouter::volumioPlay
Sep 12 22:14:34 volumio volumio[994]: info: CoreStateMachine::play index 0
Sep 12 22:14:34 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:34 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:34 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:34 volumio volumio[994]: info: CoreStateMachine::play index undefined
Sep 12 22:14:34 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:34 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:34 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer
Sep 12 22:14:34 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:34 volumio volumio[994]: info: [1757704474319] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/grunge/mp3-192/volumio
Sep 12 22:14:34 volumio volumio[994]: info: [1757704474320] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=253&count=2
Sep 12 22:14:34 volumio volumio[994]: info: [1757704474543] [80s80s] received new event containing 2 songs.
Sep 12 22:14:34 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop
Sep 12 22:14:40 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:40 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 12 22:14:40 volumio volumio[994]: info: CoreStateMachine::ClearQueue
Sep 12 22:14:40 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:40 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:40 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue
Sep 12 22:14:40 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:40 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:40 volumio volumio[994]: info: CoreStateMachine::addQueueItems
Sep 12 22:14:40 volumio volumio[994]: info: CorePlayQueue::addQueueItems
Sep 12 22:14:40 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:40 volumio volumio[994]: info: Adding Item to queue: webnineties/0
Sep 12 22:14:40 volumio volumio[994]: info: Exploding uri webnineties/0 in service 80s80s
Sep 12 22:14:40 volumio volumio[994]: info: [1757704480449] [80s80s] explodeUri: webnineties/0
Sep 12 22:14:40 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:40 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:40 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock
Sep 12 22:14:40 volumio volumio[994]: info: CorePlayQueue::getTrackBlock
Sep 12 22:14:40 volumio volumio[994]: info: CoreCommandRouter::volumioPlay
Sep 12 22:14:40 volumio volumio[994]: info: CoreStateMachine::play index 0
Sep 12 22:14:40 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:40 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:40 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:40 volumio volumio[994]: info: CoreStateMachine::play index undefined
Sep 12 22:14:40 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:40 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:40 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer
Sep 12 22:14:40 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:40 volumio volumio[994]: info: [1757704480460] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/pop/mp3-192/volumio
Sep 12 22:14:40 volumio volumio[994]: info: [1757704480460] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=141&count=2
Sep 12 22:14:40 volumio volumio[994]: info: [1757704480707] [80s80s] received new event containing 2 songs.
Sep 12 22:14:40 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop
Sep 12 22:14:41 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::ClearQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::addQueueItems
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::addQueueItems
Sep 12 22:14:41 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:41 volumio volumio[994]: info: Adding Item to queue: webnineties/0
Sep 12 22:14:41 volumio volumio[994]: info: Using cached record of: webnineties/0
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::getTrackBlock
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioPlay
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::play index 0
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::play index undefined
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:41 volumio volumio[994]: info: [1757704481167] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/pop/mp3-192/volumio
Sep 12 22:14:41 volumio volumio[994]: info: [1757704481167] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=141&count=2
Sep 12 22:14:41 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::ClearQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::addQueueItems
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::addQueueItems
Sep 12 22:14:41 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:41 volumio volumio[994]: info: Adding Item to queue: webnineties/0
Sep 12 22:14:41 volumio volumio[994]: info: Using cached record of: webnineties/0
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::getTrackBlock
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioPlay
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::play index 0
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::play index undefined
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:41 volumio volumio[994]: info: [1757704481447] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/pop/mp3-192/volumio
Sep 12 22:14:41 volumio volumio[994]: info: [1757704481447] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=141&count=2
Sep 12 22:14:41 volumio volumio[994]: info: [1757704481508] [80s80s] received new event containing 2 songs.
Sep 12 22:14:41 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop
Sep 12 22:14:41 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::ClearQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::addQueueItems
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::addQueueItems
Sep 12 22:14:41 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:41 volumio volumio[994]: info: Adding Item to queue: webnineties/0
Sep 12 22:14:41 volumio volumio[994]: info: Using cached record of: webnineties/0
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::getTrackBlock
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioPlay
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::play index 0
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::play index undefined
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:41 volumio volumio[994]: info: [1757704481670] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/pop/mp3-192/volumio
Sep 12 22:14:41 volumio volumio[994]: info: [1757704481671] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=141&count=2
Sep 12 22:14:41 volumio volumio[994]: info: [1757704481673] [80s80s] received new event containing 2 songs.
Sep 12 22:14:41 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop
Sep 12 22:14:41 volumio volumio[994]: info: [1757704481789] [80s80s] received new event containing 2 songs.
Sep 12 22:14:41 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop
Sep 12 22:14:41 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::ClearQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::addQueueItems
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::addQueueItems
Sep 12 22:14:41 volumio volumio[994]: info: Preload queue cleared
Sep 12 22:14:41 volumio volumio[994]: info: Adding Item to queue: webnineties/0
Sep 12 22:14:41 volumio volumio[994]: info: Using cached record of: webnineties/0
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::saveQueue
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::getTrackBlock
Sep 12 22:14:41 volumio volumio[994]: info: CoreCommandRouter::volumioPlay
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::play index 0
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::stop
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::play index undefined
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:41 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer
Sep 12 22:14:41 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:14:41 volumio volumio[994]: info: [1757704481905] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/pop/mp3-192/volumio
Sep 12 22:14:41 volumio volumio[994]: info: [1757704481905] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=141&count=2
Sep 12 22:14:42 volumio volumio[994]: info: [1757704482033] [80s80s] received new event containing 2 songs.
Sep 12 22:14:42 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop
Sep 12 22:14:44 volumio volumio[994]: info: CoreCommandRouter::volumioGetState
Sep 12 22:14:44 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:15:02 volumio kernel: usb 2-1: new SuperSpeed USB device number 2 using xhci_hcd
Sep 12 22:15:02 volumio kernel: usb 2-1: New USB device found, idVendor=152d, idProduct=0583, bcdDevice= 4.14
Sep 12 22:15:02 volumio kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Sep 12 22:15:02 volumio kernel: usb 2-1: Product: YzWy Disk Device
Sep 12 22:15:02 volumio kernel: usb 2-1: Manufacturer: jack88888
Sep 12 22:15:02 volumio kernel: usb 2-1: SerialNumber: DD564198338A1
Sep 12 22:15:02 volumio kernel: scsi host1: uas
Sep 12 22:15:02 volumio kernel: scsi 1:0:0:0: Direct-Access Shenzhen YongzhenWeiye 0414 PQ: 0 ANSI: 6
Sep 12 22:15:02 volumio kernel: sd 1:0:0:0: Attached scsi generic sg1 type 0
Sep 12 22:15:02 volumio kernel: sd 1:0:0:0: [sdb] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB)
Sep 12 22:15:02 volumio kernel: sd 1:0:0:0: [sdb] 4096-byte physical blocks
Sep 12 22:15:02 volumio kernel: sd 1:0:0:0: [sdb] Write Protect is off
Sep 12 22:15:02 volumio kernel: sd 1:0:0:0: [sdb] Mode Sense: 53 00 00 08
Sep 12 22:15:02 volumio kernel: sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Sep 12 22:15:02 volumio kernel: sd 1:0:0:0: [sdb] Preferred minimum I/O size 4096 bytes
Sep 12 22:15:02 volumio kernel: sd 1:0:0:0: [sdb] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes)
Sep 12 22:15:02 volumio kernel: sdb: sdb1 sdb2
Sep 12 22:15:02 volumio kernel: sd 1:0:0:0: [sdb] Attached SCSI disk
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 12 22:15:08 volumio volumio[994]: info: Retrieving Cloud Streaming UI
Sep 12 22:15:08 volumio volumio[994]: info: Getting Tidal Cloud Configuration
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 12 22:15:08 volumio volumio[994]: info: Getting Qobuz Cloud Configuration
Sep 12 22:15:08 volumio volumio[994]: info: Asking plugin for UI Config
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 12 22:15:08 volumio volumio[994]: info: Getting Spotify Cloud Configuration
Sep 12 22:15:08 volumio volumio[994]: info: Asking plugin for UI Config
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 12 22:15:08 volumio volumio[994]: info: Saving Spotify Acccount
Sep 12 22:15:08 volumio volumio[994]: info: Got Tidal Cloud Configuration
Sep 12 22:15:08 volumio volumio[994]: info: Got it
Sep 12 22:15:08 volumio volumio[994]: info: Got it
Sep 12 22:15:08 volumio volumio[994]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 12 22:15:08 volumio volumio[994]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 12 22:15:08 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 12 22:15:10 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Sep 12 22:15:10 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand update
Sep 12 22:15:11 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Sep 12 22:15:11 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand rescan
Sep 12 22:15:12 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 12 22:15:14 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Sep 12 22:15:14 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand rescan
Sep 12 22:15:16 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 12 22:15:18 volumio kernel: usb 1-1.2: USB disconnect, device number 3
Sep 12 22:15:18 volumio volumio[994]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.2:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/b02e9422-01 /dev/disk/by-uuid/01DC19BDDC5B5A40 /dev/disk/by-id/usb-JetFlash_TS1GJFV30_G3NRBNXQ-0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.2/1-1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"26","ID_BUS":"usb","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"01DC19BDDC5B5A40","ID_FS_UUID_ENC":"01DC19BDDC5B5A40","ID_INSTANCE":"0:0","ID_MODEL":"TS1GJFV30","ID_MODEL_ENC":"TS1GJFV30\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"6387","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"8192","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"1994752","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"b02e9422-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"b02e9422","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"8.07","ID_SERIAL":"JetFlash_TS1GJFV30_G3NRBNXQ-0:0","ID_SERIAL_SHORT":"G3NRBNXQ","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"JetFlash","ID_VENDOR_ENC":"JetFlash","ID_VENDOR_ID":"058f","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2449","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"3846741"}
Sep 12 22:15:18 volumio systemd[1]: media-01DC19BDDC5B5A40.mount: Succeeded.
Sep 12 22:15:18 volumio sudo[3705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1
Sep 12 22:15:18 volumio sudo[3705]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 12 22:15:18 volumio ntfs-3g[1092]: Unmounting /dev/sda1 ()
Sep 12 22:15:18 volumio sudo[3705]: pam_unix(sudo:session): session closed for user root
Sep 12 22:15:20 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 12 22:15:22 volumio volumio[994]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/01DC19BDDC5B5A40
Sep 12 22:15:33 volumio kernel: sd 1:0:0:0: [sdb] tag#23 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD IN
Sep 12 22:15:33 volumio kernel: sd 1:0:0:0: [sdb] tag#23 CDB: opcode=0x28 28 00 4f d1 13 db 00 00 08 00
Sep 12 22:15:33 volumio kernel: sd 1:0:0:0: [sdb] tag#21 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD IN
Sep 12 22:15:33 volumio kernel: sd 1:0:0:0: [sdb] tag#21 CDB: opcode=0x28 28 00 00 00 09 88 00 00 f8 00
Sep 12 22:15:33 volumio kernel: xhci_hcd 0000:01:00.0: WARNING: Host System Error
Sep 12 22:15:37 volumio volumio-remote-updater[652]: [2025-09-12 22:15:37] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006]
Sep 12 22:15:38 volumio kernel: xhci_hcd 0000:01:00.0: xHCI host not responding to stop endpoint command
Sep 12 22:15:38 volumio kernel: xhci_hcd 0000:01:00.0: xHCI host controller not responding, assume dead
Sep 12 22:15:38 volumio kernel: xhci_hcd 0000:01:00.0: HC died; cleaning up
Sep 12 22:15:38 volumio kernel: usb 1-1: USB disconnect, device number 2
Sep 12 22:15:38 volumio kernel: sd 1:0:0:0: [sdb] tag#20 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD
Sep 12 22:15:38 volumio kernel: sd 1:0:0:0: [sdb] tag#20 CDB: opcode=0x28 28 00 00 00 08 c8 00 00 30 00
Sep 12 22:15:38 volumio kernel: usb 2-1: USB disconnect, device number 2
Sep 12 22:15:39 volumio kernel: sd 1:0:0:0: Device offlined - not ready after error recovery
Sep 12 22:15:39 volumio kernel: sd 1:0:0:0: Device offlined - not ready after error recovery
Sep 12 22:15:39 volumio kernel: sd 1:0:0:0: Device offlined - not ready after error recovery
Sep 12 22:15:39 volumio kernel: sd 1:0:0:0: [sdb] tag#20 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=35s
Sep 12 22:15:39 volumio kernel: sd 1:0:0:0: [sdb] tag#20 CDB: opcode=0x28 28 00 00 00 08 c8 00 00 30 00
Sep 12 22:15:39 volumio kernel: sd 1:0:0:0: [sdb] tag#21 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=35s
Sep 12 22:15:39 volumio kernel: sd 1:0:0:0: [sdb] tag#21 CDB: opcode=0x28 28 00 00 00 09 88 00 00 f8 00
Sep 12 22:15:39 volumio kernel: sd 1:0:0:0: [sdb] tag#23 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=35s
Sep 12 22:15:39 volumio kernel: sd 1:0:0:0: [sdb] tag#23 CDB: opcode=0x28 28 00 4f d1 13 db 00 00 08 00
Sep 12 22:15:39 volumio kernel: Buffer I/O error on dev sdb2, logical block 2048, async page read
Sep 12 22:15:39 volumio kernel: Buffer I/O error on dev sdb1, logical block 9, async page read
Sep 12 22:15:39 volumio kernel: Buffer I/O error on dev sdb2, logical block 2049, async page read
Sep 12 22:15:39 volumio kernel: Buffer I/O error on dev sdb2, logical block 2050, async page read
Sep 12 22:15:39 volumio kernel: Buffer I/O error on dev sdb2, logical block 2051, async page read
Sep 12 22:15:39 volumio kernel: Buffer I/O error on dev sdb1, logical block 2, async page read
Sep 12 22:15:39 volumio kernel: sd 1:0:0:0: [sdb] Synchronizing SCSI cache
Sep 12 22:15:39 volumio kernel: sd 1:0:0:0: [sdb] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
Sep 12 22:15:39 volumio kernel: xhci_hcd 0000:01:00.0: WARN Can't disable streams for endpoint 0x82, streams are being disabled already
Sep 12 22:15:42 volumio volumio-remote-updater[652]: [2025-09-12 22:15:42] [connect] Successful connection
Sep 12 22:15:48 volumio systemd[1]: mpd.service: State 'stop-sigterm' timed out. Killing.
Sep 12 22:15:48 volumio systemd[1]: mpd.service: Killing process 1195 (mpd) with signal SIGKILL.
Sep 12 22:15:49 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=9/KILL
Sep 12 22:15:49 volumio systemd[1]: mpd.service: Failed with result 'timeout'.
Sep 12 22:15:49 volumio systemd[1]: Stopped Music Player Daemon.
Sep 12 22:15:49 volumio systemd[1]: Starting Music Player Daemon...
Sep 12 22:15:49 volumio sudo[3795]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 12 22:15:49 volumio sudo[3795]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 12 22:15:49 volumio sudo[3795]: pam_unix(sudo:session): session closed for user root
Sep 12 22:15:49 volumio mpd[3798]: Sep 12 22:15 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 12 22:15:49 volumio systemd[1]: Started Music Player Daemon.
Sep 12 22:15:49 volumio mpd_monitor.sh[625]: MPD Monitor Service: MPD restarted due to no mpc output.
Sep 12 22:15:49 volumio volumio[994]: info: Scanning removed location : "USB/01DC19BDDC5B5A40"
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Sep 12 22:15:49 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand update
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Sep 12 22:15:49 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand rescan
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Sep 12 22:15:49 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand rescan
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Sep 12 22:15:49 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand rescan
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Sep 12 22:15:49 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand rescan
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Sep 12 22:15:49 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand update
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 12 22:15:49 volumio volumio[994]: info: CoreCommandRouter::volumioGetState
Sep 12 22:15:49 volumio volumio[994]: info: CorePlayQueue::getTrack 0
Sep 12 22:15:49 volumio volumio[994]: error: MPD error: Error: write EPIPE
Sep 12 22:15:49 volumio volumio[994]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
Sep 12 22:15:49 volumio volumio[994]: error: Cannot associate FS Label, not mounting
Sep 12 22:15:49 volumio volumio[994]: error: Upnp client error: Error: read ECONNRESET
Sep 12 22:15:49 volumio volumio[994]: error: Cannot associate FS Label, not mounting
Sep 12 22:15:49 volumio volumio[994]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Sep 12 22:15:49 volumio volumio[994]: verbose: New Socket.io Connection to 192.168.1.72 from 192.168.1.54 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 YaBrowser/25.8.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Sep 12 22:15:49 volumio volumio[994]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Sep 12 22:15:49 volumio volumio[994]: verbose: New Socket.io Connection to 192.168.1.72 from 192.168.1.54 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 YaBrowser/25.8.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Sep 12 22:15:49 volumio volumio[994]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Sep 12 22:15:49 volumio volumio[994]: verbose: New Socket.io Connection to 192.168.1.72 from 192.168.1.54 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 YaBrowser/25.8.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Sep 12 22:15:49 volumio volumio[994]: verbose: New Socket.io Connection to 192.168.1.72 from 192.168.1.54 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 YaBrowser/25.8.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Sep 12 22:15:49 volumio volumio[994]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Sep 12 22:15:49 volumio volumio[994]: verbose: New Socket.io Connection to 192.168.1.72 from 192.168.1.54 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 YaBrowser/25.8.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Sep 12 22:15:49 volumio volumio[994]: verbose: New Socket.io Connection to 192.168.1.72 from 192.168.1.54 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 YaBrowser/25.8.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Sep 12 22:15:49 volumio volumio[994]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Sep 12 22:15:49 volumio volumio[994]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/ata-SSD_1TB_SN_on_the_lable_0289-part1","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"28","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"254","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"2","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"2","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"0","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_MODEL":"SSD_1TB","ID_MODEL_ENC":"SSD\\x201TB\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"fc667180-ed07-03b7-609c-19ff41fbed00","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"X1024C0","ID_SERIAL":"SSD_1TB_SN_on_the_lable_0289","ID_SERIAL_SHORT":"SN_on_the_lable_0289","ID_TYPE":"disk","MAJOR":"8","MINOR":"17","PARTN":"1","PARTNAME":"Basic data partition","SEQNUM":"2472","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"548370843"}
Sep 12 22:15:49 volumio volumio[994]: error: Cannot associate FS Label, not mounting
Sep 12 22:15:49 volumio volumio[994]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part2 /dev/disk/by-id/ata-SSD_1TB_SN_on_the_lable_0289-part2","DEVNAME":"/dev/sdb2","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb2","DEVTYPE":"partition","DISKSEQ":"28","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"254","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"2","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"2","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"0","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_MODEL":"SSD_1TB","ID_MODEL_ENC":"SSD\\x201TB\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"fc667180-ed07-03b7-609c-19ff41fbed00","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"X1024C0","ID_SERIAL":"SSD_1TB_SN_on_the_lable_0289","ID_SERIAL_SHORT":"SN_on_the_lable_0289","ID_TYPE":"disk","MAJOR":"8","MINOR":"18","PARTN":"2","PARTNAME":"Basic data partition","SEQNUM":"2473","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"548370843"}
Sep 12 22:15:49 volumio volumio[994]: error: Cannot associate FS Label, not mounting
Sep 12 22:15:50 volumio sudo[3821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 12 22:15:50 volumio sudo[3821]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 12 22:15:50 volumio sudo[3821]: pam_unix(sudo:session): session closed for user root
Sep 12 22:15:50 volumio sudo[3824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 12 22:15:50 volumio sudo[3824]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 12 22:15:50 volumio volumio[994]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 12 22:15:50 volumio sudo[3824]: pam_unix(sudo:session): session closed for user root
Sep 12 22:15:50 volumio volumio[994]: Error: getaddrinfo -3007
Sep 12 22:15:50 volumio volumio[994]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Sep 12 22:15:50 volumio volumio[994]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Sep 12 22:15:50 volumio volumio[994]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Sep 12 22:15:50 volumio volumio[994]: code: -3007,
Sep 12 22:15:50 volumio volumio[994]: errno: -3007,
Sep 12 22:15:50 volumio volumio[994]: syscall: 'getaddrinfo'
Sep 12 22:15:50 volumio volumio[994]: }
Sep 12 22:15:50 volumio volumio[994]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 12 22:15:50 volumio sudo[3835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-12 22:14
Sep 12 22:15:50 volumio sudo[3835]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"