-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Mon 2025-05-19 11:56:44 CEST. -- May 19 11:55:03 volumio volumio[967]: info: CoreCommandRouter::volumioSeek May 19 11:55:03 volumio volumio[967]: info: CoreStateMachine::seek May 19 11:55:03 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:03 volumio volumio[967]: info: TRACKBLOCK {"uri":"mnt/NAS/music/D O W N L O A D/02_THE_CHURCH_-_The_Blurred_Crusade_(1982)_[FLAC]/CD_The_Blurred_Crusade/01 - Almost With You.flac","service":"mpd","name":"Almost With You","artist":"The Church","album":"The Blurred Crusade","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=520&web=The%20Church/The%20Blurred%20Crusade/extralarge&path=%2FNAS%2Fmusic%2FD%20O%20W%20N%20L%20O%20A%20D%2F02_THE_CHURCH_-_The_Blurred_Crusade_(1982)_%5BFLAC%5D%2FCD_The_Blurred_Crusade&metadata=false","duration":251,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2} May 19 11:55:03 volumio volumio[967]: info: CoreStateMachine::startPlaybackTimer May 19 11:55:03 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:03 volumio volumio[967]: info: ControllerMpd::seek May 19 11:55:03 volumio volumio[967]: info: CoreStateMachine::pushState May 19 11:55:03 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:03 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 11:55:03 volumio volumio[967]: info: CoreCommandRouter::volumioPushState May 19 11:55:03 volumio volumio[967]: info: CoreCommandRouter::volumioGetState May 19 11:55:03 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:04 volumio volumio[967]: info: PeppyMeterBasic ---peppymeterbasic status pause May 19 11:55:04 volumio volumio[967]: error: null May 19 11:55:04 volumio volumio[967]: info: May 19 11:55:04 volumio volumio[967]: ---------------------------- MPD announces state update: player May 19 11:55:04 volumio volumio[967]: info: ControllerMpd::getState May 19 11:55:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status May 19 11:55:04 volumio volumio[967]: info: May 19 11:55:04 volumio volumio[967]: ---------------------------- MPD announces state update: player May 19 11:55:04 volumio volumio[967]: info: ControllerMpd::getState May 19 11:55:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status May 19 11:55:04 volumio volumio[967]: info: sendMpdCommand status took 40 milliseconds May 19 11:55:04 volumio volumio[967]: info: sendMpdCommand status took 24 milliseconds May 19 11:55:04 volumio volumio[967]: verbose: ControllerMpd::parseState May 19 11:55:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 11:55:04 volumio volumio[967]: verbose: ControllerMpd::parseState May 19 11:55:04 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 11:55:04 volumio sudo[17642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 19 11:55:04 volumio volumio[967]: info: sendMpdCommand playlistinfo took 10 milliseconds May 19 11:55:04 volumio sudo[17642]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 11:55:04 volumio volumio[967]: info: sendMpdCommand playlistinfo took 10 milliseconds May 19 11:55:04 volumio volumio[967]: verbose: ControllerMpd::parseTrackInfo May 19 11:55:04 volumio volumio[967]: verbose: ControllerMpd::parseTrackInfo May 19 11:55:04 volumio volumio[967]: info: ControllerMpd::pushState May 19 11:55:04 volumio volumio[967]: info: CoreCommandRouter::servicePushState May 19 11:55:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:04 volumio volumio[967]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":9000,"duration":251,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1054 Kbps","isStreaming":false,"title":"Almost With You","artist":"The Church","album":"The Blurred Crusade","uri":"NAS/music/D O W N L O A D/02_THE_CHURCH_-_The_Blurred_Crusade_(1982)_[FLAC]/CD_The_Blurred_Crusade/01 - Almost With You.flac","trackType":"flac"} May 19 11:55:04 volumio volumio[967]: verbose: CURRENT POSITION 0 May 19 11:55:04 volumio volumio[967]: info: CoreStateMachine::syncState stateService pause May 19 11:55:04 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus pause May 19 11:55:04 volumio volumio[967]: info: CoreStateMachine::pushState May 19 11:55:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:04 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 11:55:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState May 19 11:55:04 volumio volumio[967]: info: CoreCommandRouter::volumioGetState May 19 11:55:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:04 volumio volumio[967]: info: CoreStateMachine::stPlaybackTimer May 19 11:55:04 volumio volumio[967]: info: ControllerMpd::pushState May 19 11:55:04 volumio volumio[967]: info: CoreCommandRouter::servicePushState May 19 11:55:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:04 volumio volumio[967]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":9000,"duration":251,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1054 Kbps","isStreaming":false,"title":"Almost With You","artist":"The Church","album":"The Blurred Crusade","uri":"NAS/music/D O W N L O A D/02_THE_CHURCH_-_The_Blurred_Crusade_(1982)_[FLAC]/CD_The_Blurred_Crusade/01 - Almost With You.flac","trackType":"flac"} May 19 11:55:04 volumio volumio[967]: verbose: CURRENT POSITION 0 May 19 11:55:04 volumio volumio[967]: info: CoreStateMachine::syncState stateService pause May 19 11:55:04 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus pause May 19 11:55:04 volumio volumio[967]: info: CoreStateMachine::pushState May 19 11:55:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:04 volumio volumio[967]: info: CoreCommandRouter::volumioPushState May 19 11:55:04 volumio volumio[967]: info: CoreCommandRouter::volumioGetState May 19 11:55:04 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:04 volumio volumio[967]: info: CoreStateMachine::stPlaybackTimer May 19 11:55:04 volumio volumio[967]: info: ------------------------------ 253ms May 19 11:55:04 volumio volumio[967]: info: ------------------------------ 230ms May 19 11:55:04 volumio sudo[17642]: pam_unix(sudo:session): session closed for user root May 19 11:55:04 volumio volumio[967]: info: PeppyMeterBasic ---peppymeterbasic status pause May 19 11:55:04 volumio volumio[967]: info: PeppyMeterBasic ---peppymeterbasic status pause May 19 11:55:04 volumio sudo[17649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 19 11:55:04 volumio sudo[17649]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 11:55:04 volumio volumio[967]: info: peppymeterbasic Daemon Stop May 19 11:55:04 volumio sudo[17651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 19 11:55:04 volumio sudo[17651]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 11:55:04 volumio sudo[17649]: pam_unix(sudo:session): session closed for user root May 19 11:55:04 volumio volumio[967]: info: peppymeterbasic Daemon Stop May 19 11:55:04 volumio sudo[17651]: pam_unix(sudo:session): session closed for user root May 19 11:55:05 volumio volumio[967]: info: peppymeterbasic Daemon Stop May 19 11:55:06 volumio volumio[967]: info: CoreCommandRouter::volumioRemoveQueueItem May 19 11:55:06 volumio volumio[967]: info: CoreStateMachine::removeQueueItem May 19 11:55:06 volumio volumio[967]: info: CorePlayQueue::removeQueueItem 1 May 19 11:55:06 volumio volumio[967]: info: CorePlayQueue::saveQueue May 19 11:55:06 volumio volumio[967]: info: CoreCommandRouter::volumioPushQueue May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioRemoveQueueItem May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::removeQueueItem May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::stop May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::setConsumeUpdateService undefined May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::updateTrackBlock May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrackBlock May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::stPlaybackTimer May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::pushState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioPushState May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioGetState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::serviceStop May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::serviceStop May 19 11:55:07 volumio volumio[967]: info: ControllerMpd::stop May 19 11:55:07 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand stop May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::removeQueueItem 0 May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::saveQueue May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioPushQueue May 19 11:55:07 volumio volumio[967]: info: PeppyMeterBasic ---peppymeterbasic status stop May 19 11:55:07 volumio volumio[967]: info: May 19 11:55:07 volumio volumio[967]: ---------------------------- MPD announces state update: player May 19 11:55:07 volumio volumio[967]: info: sendMpdCommand stop took 131 milliseconds May 19 11:55:07 volumio volumio[967]: info: ControllerMpd::getState May 19 11:55:07 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status May 19 11:55:07 volumio volumio[967]: info: sendMpdCommand status took 9 milliseconds May 19 11:55:07 volumio volumio[967]: verbose: ControllerMpd::parseState May 19 11:55:07 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 11:55:07 volumio volumio[967]: info: May 19 11:55:07 volumio volumio[967]: ---------------------------- MPD announces state update: player May 19 11:55:07 volumio volumio[967]: info: ControllerMpd::getState May 19 11:55:07 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand status May 19 11:55:07 volumio volumio[967]: info: sendMpdCommand playlistinfo took 19 milliseconds May 19 11:55:07 volumio volumio[967]: info: sendMpdCommand status took 12 milliseconds May 19 11:55:07 volumio volumio[967]: verbose: ControllerMpd::parseTrackInfo May 19 11:55:07 volumio volumio[967]: verbose: ControllerMpd::parseState May 19 11:55:07 volumio volumio[967]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 11:55:07 volumio volumio[967]: info: ControllerMpd::pushState May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::servicePushState May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::pushState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioPushState May 19 11:55:07 volumio sudo[17668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 19 11:55:07 volumio sudo[17668]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioGetState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: 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":"Almost With You","artist":"The Church","album":"The Blurred Crusade","uri":"NAS/music/D O W N L O A D/02_THE_CHURCH_-_The_Blurred_Crusade_(1982)_[FLAC]/CD_The_Blurred_Crusade/01 - Almost With You.flac","trackType":"flac"} May 19 11:55:07 volumio volumio[967]: verbose: CURRENT POSITION 0 May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::syncState stateService stop May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus stop May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::pushState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioPushState May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioGetState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: No code May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::pushState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioPushState May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioGetState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: ------------------------------ 180ms May 19 11:55:07 volumio volumio[967]: info: sendMpdCommand playlistinfo took 155 milliseconds May 19 11:55:07 volumio sudo[17668]: pam_unix(sudo:session): session closed for user root May 19 11:55:07 volumio volumio[967]: verbose: ControllerMpd::parseTrackInfo May 19 11:55:07 volumio volumio[967]: info: ControllerMpd::pushState May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::servicePushState May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::pushState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioPushState May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioGetState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: 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":"Almost With You","artist":"The Church","album":"The Blurred Crusade","uri":"NAS/music/D O W N L O A D/02_THE_CHURCH_-_The_Blurred_Crusade_(1982)_[FLAC]/CD_The_Blurred_Crusade/01 - Almost With You.flac","trackType":"flac"} May 19 11:55:07 volumio volumio[967]: verbose: CURRENT POSITION 0 May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::syncState stateService stop May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::syncState currentStatus stop May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::pushState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioPushState May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioGetState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: No code May 19 11:55:07 volumio volumio[967]: info: CoreStateMachine::pushState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioPushState May 19 11:55:07 volumio volumio[967]: info: CoreCommandRouter::volumioGetState May 19 11:55:07 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:07 volumio volumio[967]: info: ------------------------------ 317ms May 19 11:55:08 volumio volumio[967]: info: PeppyMeterBasic ---peppymeterbasic status stop May 19 11:55:08 volumio volumio[967]: info: PeppyMeterBasic ---peppymeterbasic status stop May 19 11:55:08 volumio sudo[17671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 19 11:55:08 volumio sudo[17671]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 11:55:08 volumio volumio[967]: info: PeppyMeterBasic ---peppymeterbasic status stop May 19 11:55:08 volumio volumio[967]: info: PeppyMeterBasic ---peppymeterbasic status stop May 19 11:55:08 volumio sudo[17674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 19 11:55:08 volumio sudo[17674]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 11:55:08 volumio sudo[17671]: pam_unix(sudo:session): session closed for user root May 19 11:55:08 volumio volumio[967]: info: PeppyMeterBasic ---peppymeterbasic status stop May 19 11:55:08 volumio sudo[17676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 19 11:55:08 volumio sudo[17676]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 11:55:08 volumio sudo[17679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 19 11:55:08 volumio sudo[17674]: pam_unix(sudo:session): session closed for user root May 19 11:55:08 volumio sudo[17679]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 11:55:08 volumio volumio[967]: info: PeppyMeterBasic ---peppymeterbasic status stop May 19 11:55:08 volumio sudo[17683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 19 11:55:08 volumio sudo[17676]: pam_unix(sudo:session): session closed for user root May 19 11:55:08 volumio sudo[17683]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 11:55:08 volumio sudo[17679]: pam_unix(sudo:session): session closed for user root May 19 11:55:08 volumio sudo[17688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 19 11:55:08 volumio sudo[17688]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 11:55:08 volumio volumio[967]: info: peppymeterbasic Daemon Stop May 19 11:55:08 volumio volumio[967]: info: peppymeterbasic Daemon Stop May 19 11:55:08 volumio sudo[17683]: pam_unix(sudo:session): session closed for user root May 19 11:55:08 volumio volumio[967]: info: peppymeterbasic Daemon Stop May 19 11:55:08 volumio sudo[17688]: pam_unix(sudo:session): session closed for user root May 19 11:55:08 volumio volumio[967]: info: peppymeterbasic Daemon Stop May 19 11:55:10 volumio volumio[967]: info: CoreCommandRouter::volumioGetState May 19 11:55:10 volumio volumio[967]: info: CorePlayQueue::getTrack 0 May 19 11:55:15 volumio volumio[967]: info: Preload queue cleared May 19 11:55:20 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri May 19 11:55:20 volumio volumio[967]: info: Preload queue cleared May 19 11:55:20 volumio volumio[967]: info: Preloading song: mnt/NAS/music/D O W N L O A D/02_THE_CHURCH_-_The_Blurred_Crusade_(1982)_[FLAC]/CD_The_Blurred_Crusade/01 - Almost With You.flac May 19 11:55:20 volumio volumio[967]: info: Preloading song: upnp/folder/http://192.168.9.138:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/661430/m/661934/m May 19 11:55:20 volumio volumio[967]: info: Preloading song: mnt/NAS/music/P O P/Andreas Vollenweider [1996] Greatest Hits/Andreas_Vollenweider_Greatest Hits_1996.flac May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/576927 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/576925 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/576923 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/576921 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/120480752 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/167552263 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/17837667 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/316364845 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/349166692 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/349166691 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/349166690 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/349166689 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/349166688 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/349166687 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/399473357 May 19 11:55:20 volumio volumio[967]: info: Preloading song: tidal://song/399473356 May 19 11:55:20 volumio volumio[967]: info: Preloading song: upnp/folder/http://192.168.9.132:8096/dlna/93a5bd1e-4130-4065-b2b4-e25582f78a45/contentdirectory/control@200942 May 19 11:55:20 volumio volumio[967]: info: Exploding uri mnt/NAS/music/D O W N L O A D/02_THE_CHURCH_-_The_Blurred_Crusade_(1982)_[FLAC]/CD_The_Blurred_Crusade/01 - Almost With You.flac in service mpd May 19 11:55:20 volumio volumio[967]: info: ALBUMART /albumart?cacheid=520&web=The%20Church/The%20Blurred%20Crusade/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2FD%20O%20W%20N%20L%20O%20A%20D%2F02_THE_CHURCH_-_The_Blurred_Crusade_(1982)_%5BFLAC%5D%2FCD_The_Blurred_Crusade%2F01%20-%20Almost%20With%20You.flac&metadata=false May 19 11:55:20 volumio volumio[967]: info: URI /mnt/NAS/music/D O W N L O A D/02_THE_CHURCH_-_The_Blurred_Crusade_(1982)_[FLAC]/CD_The_Blurred_Crusade/01 - Almost With You.flac May 19 11:55:20 volumio volumio[967]: info: Exploding uri upnp/folder/http://192.168.9.138:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/661430/m/661934/m in service upnp_browser May 19 11:55:20 volumio volumio[967]: info: Exploding uri mnt/NAS/music/P O P/Andreas Vollenweider [1996] Greatest Hits/Andreas_Vollenweider_Greatest Hits_1996.flac in service mpd May 19 11:55:20 volumio volumio[967]: info: Exploding uri tidal://song/576927 in service tidal May 19 11:55:20 volumio volumio[967]: info: Exploding uri tidal://song/576925 in service tidal May 19 11:55:20 volumio volumio[967]: info: Exploding uri tidal://song/576923 in service tidal May 19 11:55:20 volumio volumio[967]: info: Exploding uri tidal://song/576921 in service tidal May 19 11:55:20 volumio volumio[967]: info: Exploding uri tidal://song/120480752 in service tidal May 19 11:55:20 volumio volumio[967]: info: Exploding uri tidal://song/167552263 in service tidal May 19 11:55:20 volumio volumio[967]: info: Exploding uri tidal://song/17837667 in service tidal May 19 11:55:20 volumio volumio[967]: info: Exploding uri tidal://song/316364845 in service tidal May 19 11:55:21 volumio volumio[967]: info: Exploding uri tidal://song/349166692 in service tidal May 19 11:55:21 volumio volumio[967]: info: Exploding uri tidal://song/349166691 in service tidal May 19 11:55:21 volumio volumio[967]: info: Exploding uri tidal://song/349166690 in service tidal May 19 11:55:21 volumio volumio[967]: info: Exploding uri tidal://song/349166689 in service tidal May 19 11:55:21 volumio volumio[967]: info: Exploding uri tidal://song/349166688 in service tidal May 19 11:55:21 volumio volumio[967]: info: Exploding uri tidal://song/349166687 in service tidal May 19 11:55:21 volumio volumio[967]: info: Exploding uri tidal://song/399473357 in service tidal May 19 11:55:21 volumio volumio[967]: info: Exploding uri tidal://song/399473356 in service tidal May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 783 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 539 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 705 milliseconds May 19 11:55:21 volumio volumio[967]: info: Exploding uri upnp/folder/http://192.168.9.132:8096/dlna/93a5bd1e-4130-4065-b2b4-e25582f78a45/contentdirectory/control@200942 in service upnp_browser May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 663 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 853 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 637 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 793 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 759 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 664 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 654 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 660 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 662 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 544 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 547 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 586 milliseconds May 19 11:55:21 volumio volumio[967]: info: explodeTIDALUri took 626 milliseconds May 19 11:55:24 volumio volumio[967]: error: connect EHOSTUNREACH 192.168.9.132:8096 {"errno":-113,"code":"EHOSTUNREACH","syscall":"connect","address":"192.168.9.132","port":8096} May 19 11:55:31 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 19 11:55:31 volumio volumio[967]: info: CURURI: albums:// May 19 11:55:31 volumio volumio[967]: error: error May 19 11:55:31 volumio volumio[967]: error: error May 19 11:55:31 volumio volumio[967]: error: error May 19 11:55:34 volumio volumio[967]: Cannot compose Albumart path May 19 11:55:34 volumio volumio[967]: Cannot compose Albumart path May 19 11:55:34 volumio volumio[967]: Cannot compose Albumart path May 19 11:55:34 volumio volumio[967]: Cannot compose Albumart path May 19 11:55:34 volumio volumio[967]: Cannot compose Albumart path May 19 11:55:34 volumio volumio[967]: Cannot compose Albumart path May 19 11:55:34 volumio volumio[967]: Cannot compose Albumart path May 19 11:55:34 volumio volumio[967]: info: Preload queue cleared May 19 11:55:56 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 19 11:55:56 volumio volumio[967]: info: CURURI: albums://Thompson%20Twins/The%20Best%20Of%20Thompson%20Twins%20%20%20Greatest%20Mixes May 19 11:55:56 volumio volumio[967]: info: Preload queue cleared May 19 11:55:56 volumio volumio[967]: info: Preloading song: music-library/NAS/music/R A D I O/MIX/14.25.41 - Thompson Twins - The Best Of Thompson Twins Greatest Mixes - Lay Your Hands On Me (Remix).mp3 May 19 11:55:56 volumio volumio[967]: info: Exploding uri music-library/NAS/music/R A D I O/MIX/14.25.41 - Thompson Twins - The Best Of Thompson Twins Greatest Mixes - Lay Your Hands On Me (Remix).mp3 in service mpd May 19 11:55:56 volumio volumio[967]: error: scanFolder - failure to stat '/mnt/NAS/music/R A D I O/MIX/14.25.41 - Thompson Twins - The Best Of Thompson Twins Greatest Mixes - Lay Your Hands On Me (Remix).mp3' May 19 11:55:56 volumio volumio[967]: info: Executing endpoint getSimilarAlbums May 19 11:55:56 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums May 19 11:55:56 volumio volumio[967]: info: Executing endpoint metavolumio May 19 11:55:56 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 19 11:55:56 volumio volumio[967]: info: Executing endpoint metavolumio May 19 11:55:56 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 19 11:55:58 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_music , getSuperSearchEnabledSourcesList May 19 11:55:58 volumio volumio[967]: info: CoreCommandRouter::volumioGetBrowseSources May 19 11:55:58 volumio volumio[967]: info: CoreCommandRouter::volumioGetBrowseSources May 19 11:55:58 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , search May 19 11:55:58 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: tidal , search May 19 11:55:58 volumio volumio[967]: info: searchTIDALUri took 349 milliseconds May 19 11:55:58 volumio volumio[967]: info: search took 352 milliseconds May 19 11:55:58 volumio volumio[967]: info: All search sources collected, pushing search results May 19 11:55:58 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 19 11:55:58 volumio volumio[967]: info: CURURI: artists://Thompson%20Twins May 19 11:55:58 volumio volumio[967]: info: Preload queue cleared May 19 11:55:58 volumio volumio[967]: info: Preload queue cleared May 19 11:55:58 volumio volumio[967]: info: Preloading song: music-library/NAS/music/R A D I O/MIX/14.28.39 - Thompson Twins - Hold Me Now - Hold Me Now (Extended Version).mp3 May 19 11:55:58 volumio volumio[967]: info: Exploding uri music-library/NAS/music/R A D I O/MIX/14.28.39 - Thompson Twins - Hold Me Now - Hold Me Now (Extended Version).mp3 in service mpd May 19 11:55:58 volumio volumio[967]: error: scanFolder - failure to stat '/mnt/NAS/music/R A D I O/MIX/14.28.39 - Thompson Twins - Hold Me Now - Hold Me Now (Extended Version).mp3' May 19 11:55:58 volumio volumio[967]: info: Executing endpoint getSimilarArtists May 19 11:55:58 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists May 19 11:55:58 volumio volumio[967]: info: Executing endpoint metavolumio May 19 11:55:58 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 19 11:56:03 volumio volumio[967]: error: Failed request for metavolumio API May 19 11:56:03 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 19 11:56:03 volumio volumio[967]: info: CURURI: artists://Thompson%20Twins/Hold%20Me%20Now May 19 11:56:04 volumio volumio[967]: info: Preload queue cleared May 19 11:56:04 volumio volumio[967]: info: Executing endpoint getSimilarAlbums May 19 11:56:04 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums May 19 11:56:04 volumio volumio[967]: info: Executing endpoint metavolumio May 19 11:56:04 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 19 11:56:05 volumio volumio[967]: info: Executing endpoint metavolumio May 19 11:56:05 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 19 11:56:07 volumio volumio[967]: info: Executing endpoint metavolumio May 19 11:56:07 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 19 11:56:22 volumio volumio[967]: error: error May 19 11:56:22 volumio volumio[967]: error: error May 19 11:56:23 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 19 11:56:23 volumio volumio[967]: info: Preload queue cleared May 19 11:56:26 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 19 11:56:26 volumio volumio[967]: info: Preload queue cleared May 19 11:56:27 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 19 11:56:28 volumio volumio[967]: info: Preload queue cleared May 19 11:56:34 volumio volumio[967]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 19 11:56:38 volumio volumio[967]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 19 11:56:38 volumio volumio[967]: TypeError: Cannot read property 'length' of undefined May 19 11:56:38 volumio volumio[967]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 19 11:56:38 volumio volumio[967]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 19 11:56:38 volumio volumio[967]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 19 11:56:38 volumio volumio[967]: at Parser.emit (events.js:315:20) May 19 11:56:38 volumio volumio[967]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 19 11:56:38 volumio volumio[967]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 19 11:56:38 volumio volumio[967]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 19 11:56:38 volumio volumio[967]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 19 11:56:38 volumio volumio[967]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 19 11:56:38 volumio volumio[967]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 19 11:56:38 volumio volumio[967]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 19 11:56:38 volumio volumio[967]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 19 11:56:38 volumio volumio[967]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 19 11:56:38 volumio volumio[967]: at IncomingMessage.emit (events.js:327:22) May 19 11:56:38 volumio volumio[967]: at endReadableNT (internal/streams/readable.js:1327:12) May 19 11:56:38 volumio volumio[967]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 19 11:56:38 volumio volumio[967]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 19 11:56:44 volumio sudo[17926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-19 11:55 May 19 11:56:44 volumio sudo[17926]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"