-- Logs begin at Sat 2025-10-25 13:24:46 CST, end at Sat 2025-10-25 13:31:40 CST. --
Oct 25 13:30:07 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:07 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:30:10 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:10 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:30:22 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:22 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:30:22 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:22 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:30:34 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:34 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:30:37 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:37 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:30:43 volumiosurf4 sudo[3067]:  volumio : unable to resolve host volumiosurf4
Oct 25 13:30:43 volumiosurf4 sudo[3067]:  volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Oct 25 13:30:43 volumiosurf4 sudo[3067]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 25 13:30:43 volumiosurf4 sudo[3067]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 13:30:43 volumiosurf4 sudo[3069]:  volumio : unable to resolve host volumiosurf4
Oct 25 13:30:43 volumiosurf4 sudo[3069]:  volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Oct 25 13:30:43 volumiosurf4 sudo[3067]: pam_unix(sudo:session): session closed for user root
Oct 25 13:30:43 volumiosurf4 sudo[3069]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 25 13:30:43 volumiosurf4 sudo[3069]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 13:30:43 volumiosurf4 sudo[3069]: pam_unix(sudo:session): session closed for user root
Oct 25 13:30:43 volumiosurf4 volumio[1241]: verbose: New Socket.io Connection to 192.168.2.136 from 192.168.2.22 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetQueue
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreStateMachine::getQueue
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CorePlayQueue::getQueue
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: Listing playlists
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: Received Get System Info
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: Discovery: Getting this device information
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 25 13:30:44 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 25 13:30:45 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 25 13:30:46 volumiosurf4 volumio[1241]: info: Received Get System Info
Oct 25 13:30:46 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 25 13:30:46 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 25 13:30:46 volumiosurf4 volumio[1241]: info: Discovery: Getting this device information
Oct 25 13:30:46 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:46 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:30:46 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 13:30:46 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 25 13:30:46 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:46 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:30:52 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:52 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:30:53 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 25 13:30:53 volumiosurf4 volumio[1241]: info: CURURI: music-library
Oct 25 13:30:53 volumiosurf4 volumio[1241]: info: Preload queue cleared
Oct 25 13:30:53 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 25 13:30:55 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 25 13:30:55 volumiosurf4 volumio[1241]: info: CURURI: music-library/NAS
Oct 25 13:30:55 volumiosurf4 volumio[1241]: info: Preload queue cleared
Oct 25 13:30:58 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 25 13:30:58 volumiosurf4 volumio[1241]: info: CURURI: music-library/NAS/MusicBox
Oct 25 13:30:58 volumiosurf4 volumio[1241]: info: Preload queue cleared
Oct 25 13:30:59 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:30:59 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:05 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 25 13:31:05 volumiosurf4 volumio[1241]: info: CURURI: music-library/NAS/MusicBox/10邓丽君
Oct 25 13:31:05 volumiosurf4 volumio[1241]: info: Preload queue cleared
Oct 25 13:31:07 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:31:07 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:11 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:31:11 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: Preload queue cleared
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::ClearQueue
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::stop
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CorePlayQueue::clearPlayQueue
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CorePlayQueue::saveQueue
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioPushQueue
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::addQueueItems
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CorePlayQueue::addQueueItems
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: Preload queue cleared
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: Adding Item to queue: music-library/NAS/MusicBox/10邓丽君/《水上人》
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: Exploding uri music-library/NAS/MusicBox/10邓丽君/《水上人》 in service mpd
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ALBUMART /albumart?cacheid=172&web=%E9%82%93%E4%B8%BD%E5%90%9B%20/%E6%B0%B4%E4%B8%8A%E4%BA%BA/extralarge&path=%2Fmnt%2FNAS%2FMusicBox%2F10%E9%82%93%E4%B8%BD%E5%90%9B%2F%E3%80%8A%E6%B0%B4%E4%B8%8A%E4%BA%BA%E3%80%8B%2F01.%E6%B0%B4%E4%B8%8A%E4%BA%BA.ape&metadata=false
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: URI /mnt/NAS/MusicBox/10邓丽君/《水上人》/01.水上人.ape
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ALBUMART /albumart?cacheid=172&web=%E9%82%93%E4%B8%BD%E5%90%9B%20/%E6%B0%B4%E4%B8%8A%E4%BA%BA/extralarge&path=%2Fmnt%2FNAS%2FMusicBox%2F10%E9%82%93%E4%B8%BD%E5%90%9B%2F%E3%80%8A%E6%B0%B4%E4%B8%8A%E4%BA%BA%E3%80%8B%2F02.%E6%83%85%E4%BA%BA%E4%B8%80%E7%AC%91.ape&metadata=false
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: URI /mnt/NAS/MusicBox/10邓丽君/《水上人》/02.情人一笑.ape
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ALBUMART /albumart?cacheid=172&web=%E9%82%93%E4%B8%BD%E5%90%9B%20/%E6%B0%B4%E4%B8%8A%E4%BA%BA/extralarge&path=%2Fmnt%2FNAS%2FMusicBox%2F10%E9%82%93%E4%B8%BD%E5%90%9B%2F%E3%80%8A%E6%B0%B4%E4%B8%8A%E4%BA%BA%E3%80%8B%2F03.%E5%A6%82%E6%9E%9C%E8%83%BD%E8%AE%B8%E4%B8%80%E4%B8%AA%E6%84%BF.ape&metadata=false
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: URI /mnt/NAS/MusicBox/10邓丽君/《水上人》/03.如果能许一个愿.ape
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ALBUMART /albumart?cacheid=172&web=%E9%82%93%E4%B8%BD%E5%90%9B%20/%E6%B0%B4%E4%B8%8A%E4%BA%BA/extralarge&path=%2Fmnt%2FNAS%2FMusicBox%2F10%E9%82%93%E4%B8%BD%E5%90%9B%2F%E3%80%8A%E6%B0%B4%E4%B8%8A%E4%BA%BA%E3%80%8B%2F04.%E6%88%91%E9%A3%9E%E5%90%91%E5%89%8D%E6%96%B9.ape&metadata=false
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: URI /mnt/NAS/MusicBox/10邓丽君/《水上人》/04.我飞向前方.ape
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ALBUMART /albumart?cacheid=172&web=%E9%82%93%E4%B8%BD%E5%90%9B%20/%E6%B0%B4%E4%B8%8A%E4%BA%BA/extralarge&path=%2Fmnt%2FNAS%2FMusicBox%2F10%E9%82%93%E4%B8%BD%E5%90%9B%2F%E3%80%8A%E6%B0%B4%E4%B8%8A%E4%BA%BA%E3%80%8B%2F05.%E5%8F%AA%E8%A6%81%E4%BD%A0%E5%BF%83%E9%87%8C%E6%9C%89%E6%88%91.ape&metadata=false
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: URI /mnt/NAS/MusicBox/10邓丽君/《水上人》/05.只要你心里有我.ape
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ALBUMART /albumart?cacheid=172&web=%E9%82%93%E4%B8%BD%E5%90%9B%20/%E6%B0%B4%E4%B8%8A%E4%BA%BA/extralarge&path=%2Fmnt%2FNAS%2FMusicBox%2F10%E9%82%93%E4%B8%BD%E5%90%9B%2F%E3%80%8A%E6%B0%B4%E4%B8%8A%E4%BA%BA%E3%80%8B%2F06.%E4%B8%8D%E7%AE%A1%E4%BD%A0%E6%98%AF%E8%B0%81.ape&metadata=false
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: URI /mnt/NAS/MusicBox/10邓丽君/《水上人》/06.不管你是谁.ape
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ALBUMART /albumart?cacheid=172&web=%E9%82%93%E4%B8%BD%E5%90%9B%20/%E6%B0%B4%E4%B8%8A%E4%BA%BA/extralarge&path=%2Fmnt%2FNAS%2FMusicBox%2F10%E9%82%93%E4%B8%BD%E5%90%9B%2F%E3%80%8A%E6%B0%B4%E4%B8%8A%E4%BA%BA%E3%80%8B%2F07.%E6%9C%89%E4%B8%AA%E5%A5%B3%E5%AD%A9%E7%AD%89%E7%9D%80%E4%BD%A0.ape&metadata=false
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: URI /mnt/NAS/MusicBox/10邓丽君/《水上人》/07.有个女孩等着你.ape
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ALBUMART /albumart?cacheid=172&web=%E9%82%93%E4%B8%BD%E5%90%9B%20/%E6%B0%B4%E4%B8%8A%E4%BA%BA/extralarge&path=%2Fmnt%2FNAS%2FMusicBox%2F10%E9%82%93%E4%B8%BD%E5%90%9B%2F%E3%80%8A%E6%B0%B4%E4%B8%8A%E4%BA%BA%E3%80%8B%2F08.%E5%A6%88%E5%A6%88%E7%9A%84%E6%AD%8C.ape&metadata=false
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: URI /mnt/NAS/MusicBox/10邓丽君/《水上人》/08.妈妈的歌.ape
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ALBUMART /albumart?cacheid=172&web=%E9%82%93%E4%B8%BD%E5%90%9B%20/%E6%B0%B4%E4%B8%8A%E4%BA%BA/extralarge&path=%2Fmnt%2FNAS%2FMusicBox%2F10%E9%82%93%E4%B8%BD%E5%90%9B%2F%E3%80%8A%E6%B0%B4%E4%B8%8A%E4%BA%BA%E3%80%8B%2F09.%E8%84%B8%E5%84%BF%E5%BE%AE%E7%AC%91%E8%8A%B1%E5%84%BF%E9%A6%99.ape&metadata=false
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: URI /mnt/NAS/MusicBox/10邓丽君/《水上人》/09.脸儿微笑花儿香.ape
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ALBUMART /albumart?cacheid=172&web=%E9%82%93%E4%B8%BD%E5%90%9B%20/%E6%B0%B4%E4%B8%8A%E4%BA%BA/extralarge&path=%2Fmnt%2FNAS%2FMusicBox%2F10%E9%82%93%E4%B8%BD%E5%90%9B%2F%E3%80%8A%E6%B0%B4%E4%B8%8A%E4%BA%BA%E3%80%8B%2F10.%E5%A5%B3%E4%BA%BA%E7%9A%84%E5%8B%87%E6%B0%94.ape&metadata=false
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: URI /mnt/NAS/MusicBox/10邓丽君/《水上人》/10.女人的勇气.ape
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioPushQueue
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CorePlayQueue::saveQueue
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::updateTrackBlock
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrackBlock
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioPlay
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::play index 0
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::stop
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::play index undefined
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::startPlaybackTimer
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::clearAddPlayTracks NAS/MusicBox/10邓丽君/《水上人》/01.水上人.ape
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::sendMpdCommand stop
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: sendMpdCommand stop took 1 milliseconds
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::sendMpdCommand clear
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: sendMpdCommand clear took 1 milliseconds
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::sendMpdCommand add "NAS/MusicBox/10邓丽君/《水上人》/01.水上人.ape"
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info:
Oct 25 13:31:16 volumiosurf4 volumio[1241]: ---------------------------- MPD announces system playlist update
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: Ignoring MPD Status Update
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info:
Oct 25 13:31:16 volumiosurf4 volumio[1241]: ---------------------------- MPD announces system playlist update
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: Ignoring MPD Status Update
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: sendMpdCommand add "NAS/MusicBox/10邓丽君/《水上人》/01.水上人.ape" took 2 milliseconds
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ------------------------------ 2ms
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::sendMpdCommand play
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ------------------------------ 1ms
Oct 25 13:31:16 volumiosurf4 volumio[1241]: error: Upnp client error: Error: This socket has been ended by the other party
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: sendMpdCommand play took 1 milliseconds
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info:
Oct 25 13:31:16 volumiosurf4 volumio[1241]: ---------------------------- MPD announces state update: player
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ControllerMpd::getState
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::sendMpdCommand status
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info:
Oct 25 13:31:16 volumiosurf4 volumio[1241]: ---------------------------- MPD announces state update: player
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: sendMpdCommand status took 27 milliseconds
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ControllerMpd::getState
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::sendMpdCommand status
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::parseState
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: sendMpdCommand status took 0 milliseconds
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::parseState
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::parseTrackInfo
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ControllerMpd::pushState
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreCommandRouter::servicePushState
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"水上人","artist":"邓丽君 ","album":"水上人","uri":"NAS/MusicBox/10邓丽君/《水上人》/01.水上人.ape","trackType":"ape"}
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: CURRENT POSITION 0
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::syncState   stateService play
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::syncState   currentStatus stop
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ------------------------------ 31ms
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: ControllerMpd::parseTrackInfo
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ControllerMpd::pushState
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreCommandRouter::servicePushState
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"水上人","artist":"邓丽君 ","album":"水上人","uri":"NAS/MusicBox/10邓丽君/《水上人》/01.水上人.ape","trackType":"ape"}
Oct 25 13:31:16 volumiosurf4 volumio[1241]: verbose: CURRENT POSITION 0
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::syncState   stateService play
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::syncState   currentStatus play
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: Received an update from plugin. extracting info from payload
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::pushState
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioPushState
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreStateMachine::pushState
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioPushState
Oct 25 13:31:16 volumiosurf4 volumio[1241]: info: ------------------------------ 12ms
Oct 25 13:31:22 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:31:22 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:23 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:31:23 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:23 volumiosurf4 volumio[1241]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7
Oct 25 13:31:23 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:31:23 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:28 volumiosurf4 volumio[1241]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Oct 25 13:31:28 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:31:28 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:28 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:31:28 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 13:31:32 volumiosurf4 volumio[1241]: Invalid card number.
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 25 13:31:32 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 25 13:31:37 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:31:37 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: Preparing to save Alsa Options, stopping services first
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioGetState
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioPause
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreStateMachine::pause
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreStateMachine::stPlaybackTimer
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreStateMachine::servicePause
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::servicePause
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: ControllerMpd::pause
Oct 25 13:31:40 volumiosurf4 volumio[1241]: verbose: ControllerMpd::sendMpdCommand pause
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: Saving Audio Output to: {"output_device":{"value":"7","label":"Dummy"}}
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: Setting mixer Master for card Dummy
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: Updating Volume Controller Parameters: Device: 7 Name: Dummy Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: Disabling external Volume Control
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: Preparing to generate the ALSA configuration file
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: Reading ALSA contributions from plugins.
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info:
Oct 25 13:31:40 volumiosurf4 volumio[1241]: ---------------------------- MPD announces state update: player
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: sendMpdCommand pause took 77 milliseconds
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: ControllerMpd::getState
Oct 25 13:31:40 volumiosurf4 volumio[1241]: verbose: ControllerMpd::sendMpdCommand status
Oct 25 13:31:40 volumiosurf4 volumio[1241]: Unable to parse:
Oct 25 13:31:40 volumiosurf4 volumio[1241]:  Simple mixer control 'Master',0
Oct 25 13:31:40 volumiosurf4 volumio[1241]:   Capabilities: volume cswitch
Oct 25 13:31:40 volumiosurf4 volumio[1241]:   Playback channels: Front Left - Front Right
Oct 25 13:31:40 volumiosurf4 volumio[1241]:   Capture channels: Front Left - Front Right
Oct 25 13:31:40 volumiosurf4 volumio[1241]:   Limits: -50 - 100
Oct 25 13:31:40 volumiosurf4 volumio[1241]:   Front Left: 0 [17%] [-30.00dB] Capture [off]
Oct 25 13:31:40 volumiosurf4 volumio[1241]:   Front Right: 0 [17%] [-30.00dB] Capture [off]
Oct 25 13:31:40 volumiosurf4 volumio[1241]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: sendMpdCommand status took 8 milliseconds
Oct 25 13:31:40 volumiosurf4 volumio[1241]: verbose: ControllerMpd::parseState
Oct 25 13:31:40 volumiosurf4 volumio[1241]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 25 13:31:40 volumiosurf4 volumio[1241]: verbose: ControllerMpd::parseTrackInfo
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: ControllerMpd::pushState
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::servicePushState
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:40 volumiosurf4 volumio[1241]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":24587,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"水上人","artist":"邓丽君 ","album":"水上人","uri":"NAS/MusicBox/10邓丽君/《水上人》/01.水上人.ape","trackType":"ape"}
Oct 25 13:31:40 volumiosurf4 volumio[1241]: verbose: CURRENT POSITION 0
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreStateMachine::syncState   stateService pause
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreStateMachine::syncState   currentStatus pause
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreStateMachine::pushState
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CorePlayQueue::getTrack 0
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::volumioPushState
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreStateMachine::stPlaybackTimer
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: ------------------------------ 15ms
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 25 13:31:40 volumiosurf4 volumio[1241]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 25 13:31:40 volumiosurf4 volumio[1241]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 25 13:31:40 volumiosurf4 volumio[1241]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Object.readdirSync (fs.js:1048:3)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12)
Oct 25 13:31:40 volumiosurf4 volumio[1241]:     at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) {
Oct 25 13:31:40 volumiosurf4 volumio[1241]:   errno: -20,
Oct 25 13:31:40 volumiosurf4 volumio[1241]:   syscall: 'scandir',
Oct 25 13:31:40 volumiosurf4 volumio[1241]:   code: 'ENOTDIR',
Oct 25 13:31:40 volumiosurf4 volumio[1241]:   path: '/tmp/peppyrunning'
Oct 25 13:31:40 volumiosurf4 volumio[1241]: }
Oct 25 13:31:40 volumiosurf4 volumio[1241]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 25 13:31:40 volumiosurf4 sudo[3378]:  volumio : unable to resolve host volumiosurf4
Oct 25 13:31:40 volumiosurf4 sudo[3378]:  volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Oct 25 13:31:40 volumiosurf4 sudo[3378]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-25 13:30
Oct 25 13:31:40 volumiosurf4 sudo[3378]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"