Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.150-05:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.158-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=7.748713ms Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.169-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=https://securetoken.googleapis.com duration=18.425869ms Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.178-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=27.691304ms Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.186-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=https://google.com duration=35.840538ms Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.194-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=43.847429ms Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.208-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=57.726778ms Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.214-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=https://functions.volumio.cloud duration=62.903507ms Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.214-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=https://functions.volumio.cloud duration=61.065639ms Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.214-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=https://database.volumio.cloud duration=61.3159ms Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.259-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=https://www.googleapis.com duration=108.890106ms Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.276-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=http://pushupdates.volumio.org duration=122.113726ms Oct 12 16:52:22 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 16:52:22 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 16:52:22 sangeet volumio[1160]: info: Discovery: Getting this device information Oct 12 16:52:22 sangeet volumio[1160]: info: CoreCommandRouter::volumioGetState Oct 12 16:52:22 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:22 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.571-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=http://plugins.volumio.org duration=419.900967ms Oct 12 16:52:22 sangeet volumio[1160]: verbose: New Socket.io Connection to 192.168.1.20:3000 from 192.168.1.158 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Oct 12 16:52:22 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 16:52:22 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 16:52:22 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:22.761-05:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=143.023127ms timeout=10s endpoint=http://cddb.volumio.org duration=610.046543ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 12 16:52:23 sangeet volumio[1160]: info: CoreCommandRouter::volumioPause Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::pause Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::stPlaybackTimer Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::servicePause Oct 12 16:52:23 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:23 sangeet volumio[1160]: info: CoreCommandRouter::servicePause Oct 12 16:52:23 sangeet volumio[1160]: info: ControllerMpd::pause Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand pause Oct 12 16:52:23 sangeet volumio[1160]: info: Oct 12 16:52:23 sangeet volumio[1160]: ---------------------------- MPD announces state update: player Oct 12 16:52:23 sangeet volumio[1160]: info: sendMpdCommand pause took 3 milliseconds Oct 12 16:52:23 sangeet volumio[1160]: info: ControllerMpd::getState Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Oct 12 16:52:23 sangeet volumio[1160]: info: Oct 12 16:52:23 sangeet volumio[1160]: ---------------------------- MPD announces state update: player Oct 12 16:52:23 sangeet volumio[1160]: info: ControllerMpd::getState Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Oct 12 16:52:23 sangeet volumio[1160]: info: Oct 12 16:52:23 sangeet volumio[1160]: ---------------------------- MPD announces state update: player Oct 12 16:52:23 sangeet volumio[1160]: info: ControllerMpd::getState Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Oct 12 16:52:23 sangeet volumio[1160]: info: sendMpdCommand status took 4 milliseconds Oct 12 16:52:23 sangeet volumio[1160]: info: sendMpdCommand status took 3 milliseconds Oct 12 16:52:23 sangeet volumio[1160]: info: sendMpdCommand status took 2 milliseconds Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::parseState Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::parseState Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::parseState Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 16:52:23 sangeet volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 12 16:52:23 sangeet volumio[1160]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 12 16:52:23 sangeet volumio[1160]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::parseTrackInfo Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::parseTrackInfo Oct 12 16:52:23 sangeet volumio[1160]: verbose: ControllerMpd::parseTrackInfo Oct 12 16:52:23 sangeet volumio[1160]: info: ControllerMpd::pushState Oct 12 16:52:23 sangeet volumio[1160]: info: CoreCommandRouter::servicePushState Oct 12 16:52:23 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:23 sangeet volumio[1160]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":26661,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"956 Kbps","isStreaming":false,"title":"Revolution","artist":"The Derek Trucks Band","album":"Songlines","uri":"NAS/Gizmo2/The Derek Trucks Band/2006 - Songlines/07 Revolution.flac","trackType":"flac"} Oct 12 16:52:23 sangeet volumio[1160]: verbose: CURRENT POSITION 0 Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::syncState stateService pause Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::syncState currentStatus pause Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:23 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:23 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 16:52:23 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::stPlaybackTimer Oct 12 16:52:23 sangeet volumio[1160]: info: ControllerMpd::pushState Oct 12 16:52:23 sangeet volumio[1160]: info: CoreCommandRouter::servicePushState Oct 12 16:52:23 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:23 sangeet volumio[1160]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":26661,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"956 Kbps","isStreaming":false,"title":"Revolution","artist":"The Derek Trucks Band","album":"Songlines","uri":"NAS/Gizmo2/The Derek Trucks Band/2006 - Songlines/07 Revolution.flac","trackType":"flac"} Oct 12 16:52:23 sangeet volumio[1160]: verbose: CURRENT POSITION 0 Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::syncState stateService pause Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::syncState currentStatus pause Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:23 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:23 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::stPlaybackTimer Oct 12 16:52:23 sangeet volumio[1160]: info: ControllerMpd::pushState Oct 12 16:52:23 sangeet volumio[1160]: info: CoreCommandRouter::servicePushState Oct 12 16:52:23 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:23 sangeet volumio[1160]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":26661,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"956 Kbps","isStreaming":false,"title":"Revolution","artist":"The Derek Trucks Band","album":"Songlines","uri":"NAS/Gizmo2/The Derek Trucks Band/2006 - Songlines/07 Revolution.flac","trackType":"flac"} Oct 12 16:52:23 sangeet volumio[1160]: verbose: CURRENT POSITION 0 Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::syncState stateService pause Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::syncState currentStatus pause Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:23 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:23 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:23 sangeet volumio[1160]: info: CoreStateMachine::stPlaybackTimer Oct 12 16:52:23 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:23.961-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PAUSED positionMs=26407 volume=100 Oct 12 16:52:23 sangeet volumio[1160]: info: ------------------------------ 22ms Oct 12 16:52:23 sangeet volumio[1160]: info: ------------------------------ 20ms Oct 12 16:52:23 sangeet volumio[1160]: info: ------------------------------ 20ms Oct 12 16:52:23 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:23.965-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PAUSED positionMs=26407 volume=100 Oct 12 16:52:23 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:23.965-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="mnt/NAS/Gizmo2/The Derek Trucks Band/2006 - Songlines/07 Revolution.flac" title=Revolution Oct 12 16:52:23 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:23.966-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="mnt/NAS/Gizmo2/The Derek Trucks Band/2006 - Songlines/07 Revolution.flac" title=Revolution Oct 12 16:52:23 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:23.966-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PAUSED positionMs=26407 volume=100 Oct 12 16:52:23 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:23.967-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="mnt/NAS/Gizmo2/The Derek Trucks Band/2006 - Songlines/07 Revolution.flac" title=Revolution Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioClearQueue Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::ClearQueue Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::stop Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::updateTrackBlock Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrackBlock Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::stPlaybackTimer Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::serviceStop Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::serviceStop Oct 12 16:52:26 sangeet volumio[1160]: info: ControllerMpd::stop Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::clearPlayQueue Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::saveQueue Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushQueue Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.318-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_STOPPED positionMs=0 volume=100 Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.319-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="mnt/NAS/Gizmo2/The Derek Trucks Band/2006 - Songlines/07 Revolution.flac" title=Revolution Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.319-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_STOPPED positionMs=0 volume=100 Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.320-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id= title= Oct 12 16:52:26 sangeet volumio[1160]: info: Oct 12 16:52:26 sangeet volumio[1160]: ---------------------------- MPD announces state update: player Oct 12 16:52:26 sangeet volumio[1160]: info: sendMpdCommand stop took 16 milliseconds Oct 12 16:52:26 sangeet volumio[1160]: info: ControllerMpd::getState Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Oct 12 16:52:26 sangeet volumio[1160]: info: Oct 12 16:52:26 sangeet volumio[1160]: ---------------------------- MPD announces state update: player Oct 12 16:52:26 sangeet volumio[1160]: info: ControllerMpd::getState Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Oct 12 16:52:26 sangeet volumio[1160]: info: Oct 12 16:52:26 sangeet volumio[1160]: ---------------------------- MPD announces state update: player Oct 12 16:52:26 sangeet volumio[1160]: info: ControllerMpd::getState Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Oct 12 16:52:26 sangeet volumio[1160]: info: sendMpdCommand status took 3 milliseconds Oct 12 16:52:26 sangeet volumio[1160]: info: sendMpdCommand status took 2 milliseconds Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::parseState Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::parseState Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 16:52:26 sangeet volumio[1160]: info: sendMpdCommand status took 3 milliseconds Oct 12 16:52:26 sangeet volumio[1160]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 12 16:52:26 sangeet volumio[1160]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::parseState Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::parseTrackInfo Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::parseTrackInfo Oct 12 16:52:26 sangeet volumio[1160]: info: ControllerMpd::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::servicePushState Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: 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":"Revolution","artist":"The Derek Trucks Band","album":"Songlines","uri":"NAS/Gizmo2/The Derek Trucks Band/2006 - Songlines/07 Revolution.flac","trackType":"flac"} Oct 12 16:52:26 sangeet volumio[1160]: verbose: CURRENT POSITION 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::syncState stateService stop Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:26 sangeet volumio[1160]: info: No code Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:26 sangeet volumio[1160]: info: ControllerMpd::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::servicePushState Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: 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":"Revolution","artist":"The Derek Trucks Band","album":"Songlines","uri":"NAS/Gizmo2/The Derek Trucks Band/2006 - Songlines/07 Revolution.flac","trackType":"flac"} Oct 12 16:52:26 sangeet volumio[1160]: verbose: CURRENT POSITION 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::syncState stateService stop Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:26 sangeet volumio[1160]: info: No code Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.352-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_STOPPED positionMs=0 volume=100 Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.352-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_STOPPED positionMs=0 volume=100 Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.352-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id= title= Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.352-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id= title= Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.353-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_STOPPED positionMs=0 volume=100 Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.353-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_STOPPED positionMs=0 volume=100 Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.353-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_STOPPED positionMs=0 volume=100 Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.354-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id= title= Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.354-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id= title= Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.354-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_STOPPED positionMs=0 volume=100 Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.354-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id= title= Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.354-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id= title= Oct 12 16:52:26 sangeet volumio[1160]: info: ------------------------------ 28ms Oct 12 16:52:26 sangeet volumio[1160]: info: ------------------------------ 28ms Oct 12 16:52:26 sangeet volumio[1160]: info: sendMpdCommand playlistinfo took 22 milliseconds Oct 12 16:52:26 sangeet volumio[1160]: verbose: ControllerMpd::parseTrackInfo Oct 12 16:52:26 sangeet volumio[1160]: info: ControllerMpd::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::servicePushState Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: 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":"Revolution","artist":"The Derek Trucks Band","album":"Songlines","uri":"NAS/Gizmo2/The Derek Trucks Band/2006 - Songlines/07 Revolution.flac","trackType":"flac"} Oct 12 16:52:26 sangeet volumio[1160]: verbose: CURRENT POSITION 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::syncState stateService stop Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:26 sangeet volumio[1160]: info: No code Oct 12 16:52:26 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:52:26 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:26 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.368-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_STOPPED positionMs=0 volume=100 Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.369-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id= title= Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.369-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_STOPPED positionMs=0 volume=100 Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.369-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_STOPPED positionMs=0 volume=100 Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.369-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id= title= Oct 12 16:52:26 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:26.369-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id= title= Oct 12 16:52:26 sangeet volumio[1160]: info: ------------------------------ 38ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.324-05:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=140.996032ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.341-05:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.348-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=7.442566ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.360-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=https://securetoken.googleapis.com duration=18.099826ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.368-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=26.40604ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.377-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=https://google.com duration=35.775329ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.386-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=43.409824ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.387-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=44.674878ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.396-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=https://database.volumio.cloud duration=53.250519ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.402-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=https://functions.volumio.cloud duration=59.699699ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.406-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=https://functions.volumio.cloud duration=63.107101ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.450-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=https://www.googleapis.com duration=108.207969ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.465-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=http://pushupdates.volumio.org duration=122.078413ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.561-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=http://plugins.volumio.org duration=217.702087ms Oct 12 16:52:28 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:52:28.779-05:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" latency=138.077691ms timeout=10s endpoint=http://cddb.volumio.org duration=436.144593ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 12 16:52:28 sangeet sudo[19227]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 16:52:28 sangeet sudo[19227]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 16:52:28 sangeet sudo[19227]: pam_unix(sudo:session): session closed for user root Oct 12 16:52:28 sangeet sudo[19229]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 16:52:28 sangeet sudo[19229]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 16:52:28 sangeet sudo[19229]: pam_unix(sudo:session): session closed for user root Oct 12 16:52:28 sangeet volumio[1160]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.158 UA: Mozilla/5.0 (Linux; Android 16; SM-S911U Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.57 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 7 Oct 12 16:52:29 sangeet sudo[19233]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 16:52:29 sangeet sudo[19233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 16:52:29 sangeet sudo[19233]: pam_unix(sudo:session): session closed for user root Oct 12 16:52:29 sangeet sudo[19235]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 16:52:29 sangeet sudo[19235]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 16:52:29 sangeet sudo[19235]: pam_unix(sudo:session): session closed for user root Oct 12 16:52:29 sangeet volumio[1160]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.158 UA: Mozilla/5.0 (Linux; Android 16; SM-S911U Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.57 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 8 Oct 12 16:52:29 sangeet volumio[1160]: info: CoreCommandRouter::volumioGetState Oct 12 16:52:29 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:29 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 12 16:52:29 sangeet volumio[1160]: info: Listing playlists Oct 12 16:52:29 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 12 16:52:29 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 16:52:29 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 16:52:29 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 16:52:30 sangeet volumio[1160]: info: CoreCommandRouter::volumioGetQueue Oct 12 16:52:30 sangeet volumio[1160]: info: CoreStateMachine::getQueue Oct 12 16:52:30 sangeet volumio[1160]: info: CorePlayQueue::getQueue Oct 12 16:52:32 sangeet volumio[1160]: info: CoreCommandRouter::volumioGetVisibleSources Oct 12 16:52:32 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 16:52:33 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 16:52:33 sangeet volumio[1160]: info: CURURI: playlists Oct 12 16:52:33 sangeet volumio[1160]: info: Listing playlists Oct 12 16:52:33 sangeet volumio[1160]: info: Preload queue cleared Oct 12 16:52:36 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 16:52:36 sangeet volumio[1160]: info: CURURI: playlists/Chill Town Oct 12 16:52:36 sangeet volumio[1160]: info: Preload queue cleared Oct 12 16:52:36 sangeet volumio[1160]: info: Preloading song: mnt/NAS/Gizmo2/Big Head Todd and The Monsters/Sister Sweetly/9 - Bittersweet.m4a Oct 12 16:52:36 sangeet volumio[1160]: info: Preloading song: mnt/NAS/Gizmo2/Dire Straits/Brothers In Arms/04 Dire Straits - Your Latest Trick.flac Oct 12 16:52:36 sangeet volumio[1160]: info: Preloading song: mnt/NAS/Gizmo2/Eagles/Hell Freezes Over/06 - Hotel California.flac Oct 12 16:52:36 sangeet volumio[1160]: info: Preloading song: mnt/NAS/Gizmo2/Fleetwood Mac/50 Years - Don't Stop Disc 2/03 - Rhiannon [Will You Ever Win] [Single Version].flac Oct 12 16:52:36 sangeet volumio[1160]: info: Preloading song: mnt/NAS/Gizmo2/Genesis/We Can't Dance/09 Genesis - Hold On My Heart.flac Oct 12 16:52:36 sangeet volumio[1160]: info: Preloading song: mnt/NAS/Gizmo2/Santana/Supernatural/7 - Maria Maria.m4a Oct 12 16:52:36 sangeet volumio[1160]: info: Preloading song: mnt/NAS/Gizmo2/Scorpions/Crazy World/04 Scorpions - Wind Of Change.flac Oct 12 16:52:36 sangeet volumio[1160]: info: Preloading song: mnt/NAS/Gizmo2/Tom Petty/Full Moon Fever/04 Tom Petty - A Face In The Crowd.flac Oct 12 16:52:36 sangeet volumio[1160]: info: Preloading song: spotify:track:57MbOuT7s2ES3IW9KuZQzI Oct 12 16:52:36 sangeet volumio[1160]: info: Preloading song: mnt/NAS/Gizmo2/Eric Clapton/Pilgrim/05 Eric Clapton - One Chance.flac Oct 12 16:52:36 sangeet volumio[1160]: info: Exploding uri mnt/NAS/Gizmo2/Big Head Todd and The Monsters/Sister Sweetly/9 - Bittersweet.m4a in service mpd Oct 12 16:52:36 sangeet volumio[1160]: info: Exploding uri mnt/NAS/Gizmo2/Dire Straits/Brothers In Arms/04 Dire Straits - Your Latest Trick.flac in service mpd Oct 12 16:52:36 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=Big%20Head%20Todd%20and%20The%20Monsters/Sister%20Sweetly/large&path=%2Fmnt%2FNAS%2FGizmo2%2FBig%20Head%20Todd%20and%20The%20Monsters%2FSister%20Sweetly%2F9%20-%20Bittersweet.m4a&metadata=false Oct 12 16:52:36 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/Big Head Todd and The Monsters/Sister Sweetly/9 - Bittersweet.m4a Oct 12 16:52:36 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=Dire%20Straits/Brothers%20In%20Arms/large&path=%2Fmnt%2FNAS%2FGizmo2%2FDire%20Straits%2FBrothers%20In%20Arms%2F04%20Dire%20Straits%20-%20Your%20Latest%20Trick.flac&metadata=false Oct 12 16:52:36 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/Dire Straits/Brothers In Arms/04 Dire Straits - Your Latest Trick.flac Oct 12 16:52:36 sangeet volumio[1160]: info: Exploding uri mnt/NAS/Gizmo2/Eagles/Hell Freezes Over/06 - Hotel California.flac in service mpd Oct 12 16:52:36 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=Eagles/Hell%20Freezes%20Over%20(Geffen%2024725)/large&path=%2Fmnt%2FNAS%2FGizmo2%2FEagles%2FHell%20Freezes%20Over%2F06%20-%20Hotel%20California.flac&metadata=false Oct 12 16:52:36 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/Eagles/Hell Freezes Over/06 - Hotel California.flac Oct 12 16:52:36 sangeet volumio[1160]: info: Exploding uri mnt/NAS/Gizmo2/Fleetwood Mac/50 Years - Don't Stop Disc 2/03 - Rhiannon [Will You Ever Win] [Single Version].flac in service mpd Oct 12 16:52:36 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=Fleetwood%20Mac/50%20Years%20-%20Don't%20Stop%20Disc%202/large&path=%2Fmnt%2FNAS%2FGizmo2%2FFleetwood%20Mac%2F50%20Years%20-%20Don't%20Stop%20Disc%202%2F03%20-%20Rhiannon%20%5BWill%20You%20Ever%20Win%5D%20%5BSingle%20Version%5D.flac&metadata=false Oct 12 16:52:36 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/Fleetwood Mac/50 Years - Don't Stop Disc 2/03 - Rhiannon [Will You Ever Win] [Single Version].flac Oct 12 16:52:36 sangeet volumio[1160]: info: Exploding uri mnt/NAS/Gizmo2/Genesis/We Can't Dance/09 Genesis - Hold On My Heart.flac in service mpd Oct 12 16:52:36 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=Genesis/We%20Can't%20Dance/large&path=%2Fmnt%2FNAS%2FGizmo2%2FGenesis%2FWe%20Can't%20Dance%2F09%20Genesis%20-%20Hold%20On%20My%20Heart.flac&metadata=false Oct 12 16:52:36 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/Genesis/We Can't Dance/09 Genesis - Hold On My Heart.flac Oct 12 16:52:37 sangeet volumio[1160]: info: Exploding uri mnt/NAS/Gizmo2/Santana/Supernatural/7 - Maria Maria.m4a in service mpd Oct 12 16:52:37 sangeet volumio[1160]: error: scanFolder - failure to stat '/mnt/NAS/Gizmo2/Santana/Supernatural/7 - Maria Maria.m4a' Oct 12 16:52:37 sangeet volumio[1160]: info: Exploding uri mnt/NAS/Gizmo2/Scorpions/Crazy World/04 Scorpions - Wind Of Change.flac in service mpd Oct 12 16:52:37 sangeet volumio[1160]: info: Exploding uri mnt/NAS/Gizmo2/Tom Petty/Full Moon Fever/04 Tom Petty - A Face In The Crowd.flac in service mpd Oct 12 16:52:37 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=Scorpions/Crazy%20World/large&path=%2Fmnt%2FNAS%2FGizmo2%2FScorpions%2FCrazy%20World%2F04%20Scorpions%20-%20Wind%20Of%20Change.flac&metadata=false Oct 12 16:52:37 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/Scorpions/Crazy World/04 Scorpions - Wind Of Change.flac Oct 12 16:52:37 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=Tom%20Petty/Full%20Moon%20Fever/large&path=%2Fmnt%2FNAS%2FGizmo2%2FTom%20Petty%2FFull%20Moon%20Fever%2F04%20Tom%20Petty%20-%20A%20Face%20In%20The%20Crowd.flac&metadata=false Oct 12 16:52:37 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/Tom Petty/Full Moon Fever/04 Tom Petty - A Face In The Crowd.flac Oct 12 16:52:37 sangeet volumio[1160]: info: Exploding uri spotify:track:57MbOuT7s2ES3IW9KuZQzI in service spop Oct 12 16:52:37 sangeet volumio[1160]: SPOTIFY: EXPLODING URI:spotify:track:57MbOuT7s2ES3IW9KuZQzI Oct 12 16:52:37 sangeet volumio[1160]: error: Commandrouter: Cannot explode uri spotify:track:57MbOuT7s2ES3IW9KuZQzI from service spop: Error: Spotify API method getTrack failed: TypeError: Cannot read properties of undefined (reading 'getTrack') Oct 12 16:52:37 sangeet volumio[1160]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Oct 12 16:52:37 sangeet volumio[1160]: info: Exploding uri mnt/NAS/Gizmo2/Eric Clapton/Pilgrim/05 Eric Clapton - One Chance.flac in service mpd Oct 12 16:52:37 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=Eric%20Clapton/Pilgrim/large&path=%2Fmnt%2FNAS%2FGizmo2%2FEric%20Clapton%2FPilgrim%2F05%20Eric%20Clapton%20-%20One%20Chance.flac&metadata=false Oct 12 16:52:37 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/Eric Clapton/Pilgrim/05 Eric Clapton - One Chance.flac Oct 12 16:52:47 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 16:52:47 sangeet volumio[1160]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 12 16:52:47 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 12 16:52:47 sangeet volumio[1160]: info: Received Get System Version Oct 12 16:52:47 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 16:52:47 sangeet volumio[1160]: info: Received Get System Info Oct 12 16:52:47 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 16:52:47 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 16:52:47 sangeet volumio[1160]: info: Discovery: Getting this device information Oct 12 16:52:47 sangeet volumio[1160]: info: CoreCommandRouter::volumioGetState Oct 12 16:52:47 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:52:47 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 16:52:52 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 16:52:52 sangeet volumio[1160]: info: CURURI: artists:// Oct 12 16:52:52 sangeet volumio[1160]: info: Preload queue cleared Oct 12 16:52:57 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 16:52:57 sangeet volumio[1160]: info: CURURI: artists://The%20Weeknd Oct 12 16:52:57 sangeet volumio[1160]: info: Preload queue cleared Oct 12 16:52:57 sangeet volumio[1160]: info: Preload queue cleared Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/02 - Blinding Lights.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/03 - In Your Eyes.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/04 - Can't Feel My Face.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/05 - I Feel It Coming.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/06 - Starboy.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/07 - Pray For Me.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/08 - Heartless.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/09 - Often.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/10 - The Hills.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/11 - Call Out My Name.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/12 - Die For You.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/13 - Earned It (Fifty Shades Of Grey).flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/14 - Love Me Harder.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/15 - Acquainted.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/16 - Wicked Games.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/17 - The Morning.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/18 - After Hours.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Preloading song: music-library/NAS/Gizmo2/Top 40/01 Can't Feel My Face.mp3 Oct 12 16:52:57 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac in service mpd Oct 12 16:52:57 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F01%20-%20Save%20Your%20Tears.flac&metadata=false Oct 12 16:52:57 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/02 - Blinding Lights.flac in service mpd Oct 12 16:52:57 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F02%20-%20Blinding%20Lights.flac&metadata=false Oct 12 16:52:57 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/02 - Blinding Lights.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/03 - In Your Eyes.flac in service mpd Oct 12 16:52:57 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F03%20-%20In%20Your%20Eyes.flac&metadata=false Oct 12 16:52:57 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/03 - In Your Eyes.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/04 - Can't Feel My Face.flac in service mpd Oct 12 16:52:57 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F04%20-%20Can't%20Feel%20My%20Face.flac&metadata=false Oct 12 16:52:57 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/04 - Can't Feel My Face.flac Oct 12 16:52:57 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/05 - I Feel It Coming.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F05%20-%20I%20Feel%20It%20Coming.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/05 - I Feel It Coming.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/06 - Starboy.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F06%20-%20Starboy.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/06 - Starboy.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/07 - Pray For Me.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F07%20-%20Pray%20For%20Me.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/07 - Pray For Me.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/08 - Heartless.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F08%20-%20Heartless.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/08 - Heartless.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/09 - Often.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F09%20-%20Often.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/09 - Often.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/10 - The Hills.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F10%20-%20The%20Hills.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/10 - The Hills.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/11 - Call Out My Name.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F11%20-%20Call%20Out%20My%20Name.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/11 - Call Out My Name.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/12 - Die For You.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F12%20-%20Die%20For%20You.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/12 - Die For You.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/13 - Earned It (Fifty Shades Of Grey).flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F13%20-%20Earned%20It%20(Fifty%20Shades%20Of%20Grey).flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/13 - Earned It (Fifty Shades Of Grey).flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/14 - Love Me Harder.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=Ariana%20Grande/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F14%20-%20Love%20Me%20Harder.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/14 - Love Me Harder.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/15 - Acquainted.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F15%20-%20Acquainted.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/15 - Acquainted.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/16 - Wicked Games.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F16%20-%20Wicked%20Games.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/16 - Wicked Games.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/17 - The Morning.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F17%20-%20The%20Morning.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/17 - The Morning.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/18 - After Hours.flac in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/The%20Highlights/large&path=%2Fmnt%2FNAS%2FGizmo2%2FThe%20Weeknd%2FThe%20Highlights%20(2021)%2F18%20-%20After%20Hours.flac&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/The Weeknd/The Highlights (2021)/18 - After Hours.flac Oct 12 16:52:58 sangeet volumio[1160]: info: Exploding uri music-library/NAS/Gizmo2/Top 40/01 Can't Feel My Face.mp3 in service mpd Oct 12 16:52:58 sangeet volumio[1160]: info: ALBUMART /albumart?cacheid=429&web=The%20Weeknd/Can%E2%80%99t%20Feel%20My%20Face%20-%20Single/large&path=%2Fmnt%2FNAS%2FGizmo2%2FTop%2040%2F01%20Can't%20Feel%20My%20Face.mp3&metadata=false Oct 12 16:52:58 sangeet volumio[1160]: info: URI /mnt/NAS/Gizmo2/Top 40/01 Can't Feel My Face.mp3 Oct 12 16:53:01 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 16:53:01 sangeet volumio[1160]: info: CURURI: artists://The%20Weeknd/The%20Highlights Oct 12 16:53:01 sangeet volumio[1160]: info: Preload queue cleared Oct 12 16:53:03 sangeet volumio[1160]: info: Preload queue cleared Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::ClearQueue Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::stop Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::clearPlayQueue Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::saveQueue Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushQueue Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::addQueueItems Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::addQueueItems Oct 12 16:53:03 sangeet volumio[1160]: info: Preload queue cleared Oct 12 16:53:03 sangeet volumio[1160]: info: Adding Item to queue: artists://The%20Weeknd/The%20Highlights Oct 12 16:53:03 sangeet volumio[1160]: info: Exploding uri artists://The%20Weeknd/The%20Highlights in service mpd Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushQueue Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::saveQueue Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::updateTrackBlock Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrackBlock Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPlay Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::play index 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::stop Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::play index undefined Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::startPlaybackTimer Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::clearAddPlayTracks NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand stop took 1 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Oct 12 16:53:03 sangeet volumio[1160]: info: Oct 12 16:53:03 sangeet volumio[1160]: ---------------------------- MPD announces system playlist update Oct 12 16:53:03 sangeet volumio[1160]: info: Ignoring MPD Status Update Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand clear took 6 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac" Oct 12 16:53:03 sangeet volumio[1160]: info: Oct 12 16:53:03 sangeet volumio[1160]: ---------------------------- MPD announces system playlist update Oct 12 16:53:03 sangeet volumio[1160]: info: Ignoring MPD Status Update Oct 12 16:53:03 sangeet volumio[1160]: info: Oct 12 16:53:03 sangeet volumio[1160]: ---------------------------- MPD announces system playlist update Oct 12 16:53:03 sangeet volumio[1160]: info: Ignoring MPD Status Update Oct 12 16:53:03 sangeet volumio[1160]: error: updateQueue error: null Oct 12 16:53:03 sangeet volumio[1160]: info: Oct 12 16:53:03 sangeet volumio[1160]: ---------------------------- MPD announces system playlist update Oct 12 16:53:03 sangeet volumio[1160]: info: Ignoring MPD Status Update Oct 12 16:53:03 sangeet volumio[1160]: info: ------------------------------ 14ms Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand add "NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac" took 12 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: info: ------------------------------ 12ms Oct 12 16:53:03 sangeet volumio[1160]: info: ------------------------------ 10ms Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Oct 12 16:53:03 sangeet volumio[1160]: info: Oct 12 16:53:03 sangeet volumio[1160]: ---------------------------- MPD announces system playlist update Oct 12 16:53:03 sangeet volumio[1160]: info: Ignoring MPD Status Update Oct 12 16:53:03 sangeet volumio[1160]: info: Oct 12 16:53:03 sangeet volumio[1160]: ---------------------------- MPD announces system playlist update Oct 12 16:53:03 sangeet volumio[1160]: info: Ignoring MPD Status Update Oct 12 16:53:03 sangeet volumio[1160]: info: ------------------------------ 19ms Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand play took 15 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: info: ------------------------------ 5ms Oct 12 16:53:03 sangeet volumio[1160]: info: ------------------------------ 3ms Oct 12 16:53:03 sangeet volumio[1160]: info: Oct 12 16:53:03 sangeet volumio[1160]: ---------------------------- MPD announces state update: player Oct 12 16:53:03 sangeet kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! Oct 12 16:53:03 sangeet volumio[1160]: info: ControllerMpd::getState Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Oct 12 16:53:03 sangeet volumio[1160]: info: Oct 12 16:53:03 sangeet volumio[1160]: ---------------------------- MPD announces state update: player Oct 12 16:53:03 sangeet volumio[1160]: info: ControllerMpd::getState Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Oct 12 16:53:03 sangeet volumio[1160]: info: Oct 12 16:53:03 sangeet volumio[1160]: ---------------------------- MPD announces state update: player Oct 12 16:53:03 sangeet volumio[1160]: info: ControllerMpd::getState Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Oct 12 16:53:03 sangeet volumio[1160]: info: Oct 12 16:53:03 sangeet volumio[1160]: ---------------------------- MPD announces state update: player Oct 12 16:53:03 sangeet volumio[1160]: info: ControllerMpd::getState Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Oct 12 16:53:03 sangeet volumio[1160]: info: Oct 12 16:53:03 sangeet volumio[1160]: ---------------------------- MPD announces state update: player Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand status took 11 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: info: ControllerMpd::getState Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand status took 10 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand status took 10 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::parseState Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::parseState Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::parseState Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand status took 6 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand status took 5 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::parseState Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::parseState Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::parseTrackInfo Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::parseTrackInfo Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::parseTrackInfo Oct 12 16:53:03 sangeet volumio[1160]: info: ControllerMpd::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::servicePushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":216,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1624 Kbps","isStreaming":false,"title":"Save Your Tears","artist":"The Weeknd","album":"The Highlights","uri":"NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac","trackType":"flac"} Oct 12 16:53:03 sangeet volumio[1160]: verbose: CURRENT POSITION 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::syncState stateService play Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Oct 12 16:53:03 sangeet volumio[1160]: info: ControllerMpd::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::servicePushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":216,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1624 Kbps","isStreaming":false,"title":"Save Your Tears","artist":"The Weeknd","album":"The Highlights","uri":"NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac","trackType":"flac"} Oct 12 16:53:03 sangeet volumio[1160]: verbose: CURRENT POSITION 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::syncState stateService play Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::syncState currentStatus play Oct 12 16:53:03 sangeet volumio[1160]: info: Received an update from plugin. extracting info from payload Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:53:03 sangeet volumio[1160]: info: ControllerMpd::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::servicePushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":216,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1624 Kbps","isStreaming":false,"title":"Save Your Tears","artist":"The Weeknd","album":"The Highlights","uri":"NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac","trackType":"flac"} Oct 12 16:53:03 sangeet volumio[1160]: verbose: CURRENT POSITION 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::syncState stateService play Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::syncState currentStatus play Oct 12 16:53:03 sangeet volumio[1160]: info: Received an update from plugin. extracting info from payload Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:53:03 sangeet volumio[1160]: info: ------------------------------ 37ms Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.895-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PLAYING positionMs=881 volume=100 Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.896-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PLAYING positionMs=881 volume=100 Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.897-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PLAYING positionMs=881 volume=100 Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.898-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac" title="Save Your Tears" Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.898-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac" title="Save Your Tears" Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.899-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac" title="Save Your Tears" Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.900-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PLAYING positionMs=881 volume=100 Oct 12 16:53:03 sangeet volumio[1160]: info: ------------------------------ 42ms Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.901-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac" title="Save Your Tears" Oct 12 16:53:03 sangeet volumio[1160]: info: ------------------------------ 43ms Oct 12 16:53:03 sangeet volumio[1160]: info: Oct 12 16:53:03 sangeet volumio[1160]: ---------------------------- MPD announces state update: player Oct 12 16:53:03 sangeet volumio[1160]: info: ControllerMpd::getState Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand playlistinfo took 24 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand playlistinfo took 24 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand status took 2 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::parseTrackInfo Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::parseTrackInfo Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::parseState Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 16:53:03 sangeet volumio[1160]: info: ControllerMpd::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::servicePushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":216,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1624 Kbps","isStreaming":false,"title":"Save Your Tears","artist":"The Weeknd","album":"The Highlights","uri":"NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac","trackType":"flac"} Oct 12 16:53:03 sangeet volumio[1160]: verbose: CURRENT POSITION 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::syncState stateService play Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::syncState currentStatus play Oct 12 16:53:03 sangeet volumio[1160]: info: Received an update from plugin. extracting info from payload Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:53:03 sangeet volumio[1160]: info: ControllerMpd::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::servicePushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":216,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1624 Kbps","isStreaming":false,"title":"Save Your Tears","artist":"The Weeknd","album":"The Highlights","uri":"NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac","trackType":"flac"} Oct 12 16:53:03 sangeet volumio[1160]: verbose: CURRENT POSITION 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::syncState stateService play Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::syncState currentStatus play Oct 12 16:53:03 sangeet volumio[1160]: info: Received an update from plugin. extracting info from payload Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.920-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PLAYING positionMs=881 volume=100 Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.921-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PLAYING positionMs=881 volume=100 Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.921-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac" title="Save Your Tears" Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.922-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PLAYING positionMs=881 volume=100 Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.922-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac" title="Save Your Tears" Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.923-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac" title="Save Your Tears" Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.923-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PLAYING positionMs=881 volume=100 Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.924-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac" title="Save Your Tears" Oct 12 16:53:03 sangeet volumio[1160]: info: ------------------------------ 61ms Oct 12 16:53:03 sangeet volumio[1160]: info: ------------------------------ 60ms Oct 12 16:53:03 sangeet volumio[1160]: info: sendMpdCommand playlistinfo took 48 milliseconds Oct 12 16:53:03 sangeet volumio[1160]: verbose: ControllerMpd::parseTrackInfo Oct 12 16:53:03 sangeet volumio[1160]: info: ControllerMpd::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::servicePushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":216,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1624 Kbps","isStreaming":false,"title":"Save Your Tears","artist":"The Weeknd","album":"The Highlights","uri":"NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac","trackType":"flac"} Oct 12 16:53:03 sangeet volumio[1160]: verbose: CURRENT POSITION 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::syncState stateService play Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::syncState currentStatus play Oct 12 16:53:03 sangeet volumio[1160]: info: Received an update from plugin. extracting info from payload Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:53:03 sangeet volumio[1160]: info: CoreStateMachine::pushState Oct 12 16:53:03 sangeet volumio[1160]: info: CorePlayQueue::getTrack 0 Oct 12 16:53:03 sangeet volumio[1160]: info: CoreCommandRouter::volumioPushState Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.964-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PLAYING positionMs=881 volume=100 Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.965-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" state=STATUS_PLAYING positionMs=881 volume=100 Oct 12 16:53:03 sangeet volumio[1160]: info: ------------------------------ 63ms Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.970-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac" title="Save Your Tears" Oct 12 16:53:03 sangeet volumio5-onboarding[1379]: time=2026-10-12T16:53:03.966-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.158:53828,00:00:00:00:00:00%03 @ 0x2ae0300" id="music-library/NAS/Gizmo2/The Weeknd/The Highlights (2021)/01 - Save Your Tears.flac" title="Save Your Tears" Oct 12 16:53:08 sangeet volumio[1160]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 16:53:08 sangeet volumio[1160]: TypeError: Cannot read properties of null (reading 'slice') Oct 12 16:53:08 sangeet volumio[1160]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Oct 12 16:53:08 sangeet volumio[1160]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Oct 12 16:53:08 sangeet volumio[1160]: at Object.onceWrapper (node:events:629:26) Oct 12 16:53:08 sangeet volumio[1160]: at ClientRequest.emit (node:events:514:28) Oct 12 16:53:08 sangeet volumio[1160]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Oct 12 16:53:08 sangeet volumio[1160]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Oct 12 16:53:08 sangeet volumio[1160]: at TLSSocket.socketOnData (node:_http_client:535:22) Oct 12 16:53:08 sangeet volumio[1160]: at TLSSocket.emit (node:events:514:28) Oct 12 16:53:08 sangeet volumio[1160]: at addChunk (node:internal/streams/readable:343:12) Oct 12 16:53:08 sangeet volumio[1160]: at readableAddChunk (node:internal/streams/readable:316:9) Oct 12 16:53:08 sangeet volumio[1160]: at Readable.push (node:internal/streams/readable:253:10) Oct 12 16:53:08 sangeet volumio[1160]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Oct 12 16:53:08 sangeet volumio[1160]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 16:53:09 sangeet sudo[19323]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 16:52' Oct 12 16:53:09 sangeet sudo[19323]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"