-- Logs begin at Thu 2025-07-10 16:02:49 UTC, end at Thu 2025-07-10 16:19:22 UTC. -- Jul 10 16:18:02 volumio sudo[6340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 10 16:18:02 volumio sudo[6340]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 16:18:02 volumio sudo[6340]: pam_unix(sudo:session): session closed for user root Jul 10 16:18:02 volumio sudo[6343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 10 16:18:02 volumio sudo[6343]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 16:18:02 volumio sudo[6343]: pam_unix(sudo:session): session closed for user root Jul 10 16:18:02 volumio volumio[1005]: verbose: New Socket.io Connection to 192.168.5.242 from 192.168.5.163 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jul 10 16:18:03 volumio sudo[6351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 10 16:18:03 volumio sudo[6351]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 16:18:03 volumio sudo[6351]: pam_unix(sudo:session): session closed for user root Jul 10 16:18:03 volumio sudo[6354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 10 16:18:03 volumio sudo[6354]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 16:18:03 volumio sudo[6354]: pam_unix(sudo:session): session closed for user root Jul 10 16:18:03 volumio volumio[1005]: verbose: New Socket.io Connection to 192.168.5.242 from 192.168.5.163 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::volumioGetVisibleSources Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Jul 10 16:18:03 volumio volumio[1005]: info: CorePlayQueue::getTrack 3 Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 10 16:18:03 volumio volumio[1005]: info: Received Get System Info Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 16:18:03 volumio volumio[1005]: info: Discovery: Getting this device information Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Jul 10 16:18:03 volumio volumio[1005]: info: CorePlayQueue::getTrack 3 Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Jul 10 16:18:03 volumio volumio[1005]: info: CorePlayQueue::getTrack 3 Jul 10 16:18:03 volumio volumio[1005]: info: Listing playlists Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 10 16:18:03 volumio volumio[1005]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 10 16:18:03 volumio volumio[1005]: info: FusionDsp - Jul 10 16:18:03 volumio volumio[1005]: info: FusionDsp - undefined Jul 10 16:18:04 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Jul 10 16:18:04 volumio volumio[1005]: info: CorePlayQueue::getTrack 3 Jul 10 16:18:05 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 10 16:18:05 volumio volumio[1005]: info: Received Get System Info Jul 10 16:18:05 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 16:18:05 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 16:18:05 volumio volumio[1005]: info: Discovery: Getting this device information Jul 10 16:18:05 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Jul 10 16:18:05 volumio volumio[1005]: info: CorePlayQueue::getTrack 3 Jul 10 16:18:05 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 16:18:05 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 10 16:18:05 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 10 16:18:07 volumio volumio[1005]: info: CoreCommandRouter::volumioGetQueue Jul 10 16:18:07 volumio volumio[1005]: info: CoreStateMachine::getQueue Jul 10 16:18:07 volumio volumio[1005]: info: CorePlayQueue::getQueue Jul 10 16:18:15 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 10 16:18:16 volumio volumio[1005]: info: Received Get System Info Jul 10 16:18:16 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 16:18:16 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 16:18:16 volumio volumio[1005]: info: Discovery: Getting this device information Jul 10 16:18:16 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Jul 10 16:18:16 volumio volumio[1005]: info: CorePlayQueue::getTrack 3 Jul 10 16:18:16 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 16:18:16 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 10 16:18:23 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 10 16:18:24 volumio volumio[1005]: info: Received Get System Info Jul 10 16:18:24 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 16:18:24 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 16:18:24 volumio volumio[1005]: info: Discovery: Getting this device information Jul 10 16:18:24 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Jul 10 16:18:24 volumio volumio[1005]: info: CorePlayQueue::getTrack 3 Jul 10 16:18:24 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 16:18:36 volumio nmbd[886]: [2025/07/10 16:18:36.535561, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 10 16:18:36 volumio nmbd[886]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.5.242 for name WORKGROUP<1d>. Jul 10 16:18:36 volumio nmbd[886]: This response was from IP 192.168.5.1, reporting an IP address of 192.168.5.1. Jul 10 16:18:37 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Jul 10 16:18:37 volumio volumio[1005]: info: CorePlayQueue::getTrack 3 Jul 10 16:18:37 volumio volumio[1005]: info: CoreCommandRouter::volumioRandom Jul 10 16:18:37 volumio volumio[1005]: info: CoreCommandRouter::writePlayerControls Jul 10 16:18:37 volumio volumio[1005]: info: CorePlayQueue::getTrack 3 Jul 10 16:18:37 volumio volumio[1005]: info: CoreStateMachine::setRandom true Jul 10 16:18:37 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:37 volumio volumio[1005]: info: CorePlayQueue::getTrack 3 Jul 10 16:18:37 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 16:18:37 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::volumioNext Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::next Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::stop Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::stPlaybackTimer Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::updateTrackBlock Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrackBlock Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrack 3 Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::serviceStop Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrack 3 Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::serviceStop Jul 10 16:18:40 volumio volumio[1005]: info: ControllerMpd::stop Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand stop Jul 10 16:18:40 volumio volumio[1005]: info: Jul 10 16:18:40 volumio volumio[1005]: ---------------------------- MPD announces state update: player Jul 10 16:18:40 volumio volumio[1005]: info: sendMpdCommand stop took 11 milliseconds Jul 10 16:18:40 volumio volumio[1005]: info: ControllerMpd::getState Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::play index undefined Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrack 1436 Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::startPlaybackTimer Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrack 1436 Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::clearAddPlayTracks USB/500g/mp3/128kb转换计划/mp3流行钢琴曲超精选-110首/033两只蝴蝶.mp3 Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand stop Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::updateTrackBlock Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrackBlock Jul 10 16:18:40 volumio volumio[1005]: info: sendMpdCommand status took 25 milliseconds Jul 10 16:18:40 volumio volumio[1005]: info: sendMpdCommand stop took 8 milliseconds Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::parseState Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand clear Jul 10 16:18:40 volumio volumio[1005]: info: Jul 10 16:18:40 volumio volumio[1005]: ---------------------------- MPD announces system playlist update Jul 10 16:18:40 volumio volumio[1005]: info: Ignoring MPD Status Update Jul 10 16:18:40 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 10 16:18:40 volumio volumio[1005]: info: sendMpdCommand clear took 1 milliseconds Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand add "USB/500g/mp3/128kb转换计划/mp3流行钢琴曲超精选-110首/033两只蝴蝶.mp3" Jul 10 16:18:40 volumio volumio[1005]: info: ControllerMpd::pushState Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrack 1436 Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrack 1436 Jul 10 16:18:40 volumio volumio[1005]: 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":"佘詩曼 - 風車.mp3","artist":null,"album":null,"uri":"USB/500g/mp3/佘詩曼 - 風車.mp3","trackType":"mp3"} Jul 10 16:18:40 volumio volumio[1005]: verbose: CURRENT POSITION 1436 Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::syncState stateService stop Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus stop Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrack 1436 Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:40 volumio volumio[1005]: info: No code Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrack 1436 Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:40 volumio volumio[1005]: info: ------------------------------ 46ms Jul 10 16:18:40 volumio volumio[1005]: error: updateQueue error: null Jul 10 16:18:40 volumio volumio[1005]: info: Jul 10 16:18:40 volumio volumio[1005]: ---------------------------- MPD announces system playlist update Jul 10 16:18:40 volumio volumio[1005]: info: Ignoring MPD Status Update Jul 10 16:18:40 volumio volumio[1005]: info: ------------------------------ 19ms Jul 10 16:18:40 volumio volumio[1005]: info: sendMpdCommand add "USB/500g/mp3/128kb转换计划/mp3流行钢琴曲超精选-110首/033两只蝴蝶.mp3" took 17 milliseconds Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand play Jul 10 16:18:40 volumio volumio[1005]: info: Jul 10 16:18:40 volumio volumio[1005]: ---------------------------- MPD announces state update: player Jul 10 16:18:40 volumio volumio[1005]: info: ------------------------------ 7ms Jul 10 16:18:40 volumio volumio[1005]: info: sendMpdCommand play took 8 milliseconds Jul 10 16:18:40 volumio volumio[1005]: info: ControllerMpd::getState Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Jul 10 16:18:40 volumio volumio[1005]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 16:18:40 volumio volumio[1005]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 16:18:40 volumio volumio[1005]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 16:18:40 volumio volumio[1005]: info: Jul 10 16:18:40 volumio volumio[1005]: ---------------------------- MPD announces state update: player Jul 10 16:18:40 volumio volumio[1005]: info: sendMpdCommand status took 23 milliseconds Jul 10 16:18:40 volumio volumio[1005]: info: ControllerMpd::getState Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::parseState Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 16:18:40 volumio volumio[1005]: info: sendMpdCommand status took 2 milliseconds Jul 10 16:18:40 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::parseState Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Jul 10 16:18:40 volumio volumio[1005]: info: ControllerMpd::pushState Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrack 1436 Jul 10 16:18:40 volumio volumio[1005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":245,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"033两只蝴蝶 ","artist":"王喆","album":"简易版流行钢琴曲(超精选+新歌)","uri":"USB/500g/mp3/128kb转换计划/mp3流行钢琴曲超精选-110首/033两只蝴蝶.mp3","trackType":"mp3"} Jul 10 16:18:40 volumio volumio[1005]: verbose: CURRENT POSITION 1436 Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::syncState stateService play Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus stop Jul 10 16:18:40 volumio volumio[1005]: info: ------------------------------ 27ms Jul 10 16:18:40 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 10 16:18:40 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Jul 10 16:18:40 volumio volumio[1005]: info: ControllerMpd::pushState Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrack 1436 Jul 10 16:18:40 volumio volumio[1005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":245,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"033两只蝴蝶 ","artist":"王喆","album":"简易版流行钢琴曲(超精选+新歌)","uri":"USB/500g/mp3/128kb转换计划/mp3流行钢琴曲超精选-110首/033两只蝴蝶.mp3","trackType":"mp3"} Jul 10 16:18:40 volumio volumio[1005]: verbose: CURRENT POSITION 1436 Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::syncState stateService play Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus play Jul 10 16:18:40 volumio volumio[1005]: info: Received an update from plugin. extracting info from payload Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrack 1436 Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:40 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:40 volumio volumio[1005]: info: CorePlayQueue::getTrack 1436 Jul 10 16:18:40 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:40 volumio volumio[1005]: info: ------------------------------ 15ms Jul 10 16:18:40 volumio volumio[1005]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::volumioNext Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::next Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::stop Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::stPlaybackTimer Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::updateTrackBlock Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrackBlock Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 1436 Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::serviceStop Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 1436 Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::serviceStop Jul 10 16:18:48 volumio volumio[1005]: info: ControllerMpd::stop Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand stop Jul 10 16:18:48 volumio volumio[1005]: info: Jul 10 16:18:48 volumio volumio[1005]: ---------------------------- MPD announces state update: player Jul 10 16:18:48 volumio volumio[1005]: info: sendMpdCommand stop took 6 milliseconds Jul 10 16:18:48 volumio volumio[1005]: info: ControllerMpd::getState Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::play index undefined Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 8986 Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::startPlaybackTimer Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 8986 Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::clearAddPlayTracks USB/500g/mp3/处理完成/谭维维 - 如果有来生.flac Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand stop Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::updateTrackBlock Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrackBlock Jul 10 16:18:48 volumio volumio[1005]: info: sendMpdCommand status took 10 milliseconds Jul 10 16:18:48 volumio volumio[1005]: info: sendMpdCommand stop took 5 milliseconds Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::parseState Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand clear Jul 10 16:18:48 volumio volumio[1005]: info: Jul 10 16:18:48 volumio volumio[1005]: ---------------------------- MPD announces system playlist update Jul 10 16:18:48 volumio volumio[1005]: info: Ignoring MPD Status Update Jul 10 16:18:48 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 10 16:18:48 volumio volumio[1005]: info: sendMpdCommand clear took 1 milliseconds Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand add "USB/500g/mp3/处理完成/谭维维 - 如果有来生.flac" Jul 10 16:18:48 volumio volumio[1005]: info: ControllerMpd::pushState Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 8986 Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 8986 Jul 10 16:18:48 volumio volumio[1005]: 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":"033两只蝴蝶 ","artist":"王喆","album":"简易版流行钢琴曲(超精选+新歌)","uri":"USB/500g/mp3/128kb转换计划/mp3流行钢琴曲超精选-110首/033两只蝴蝶.mp3","trackType":"mp3"} Jul 10 16:18:48 volumio volumio[1005]: verbose: CURRENT POSITION 8986 Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::syncState stateService stop Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus stop Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 8986 Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:48 volumio volumio[1005]: info: No code Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 8986 Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:48 volumio volumio[1005]: info: ------------------------------ 43ms Jul 10 16:18:48 volumio volumio[1005]: error: updateQueue error: null Jul 10 16:18:48 volumio volumio[1005]: info: Jul 10 16:18:48 volumio volumio[1005]: ---------------------------- MPD announces system playlist update Jul 10 16:18:48 volumio volumio[1005]: info: Ignoring MPD Status Update Jul 10 16:18:48 volumio volumio[1005]: info: ------------------------------ 41ms Jul 10 16:18:48 volumio volumio[1005]: info: sendMpdCommand add "USB/500g/mp3/处理完成/谭维维 - 如果有来生.flac" took 41 milliseconds Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand play Jul 10 16:18:48 volumio volumio[1005]: info: ------------------------------ 11ms Jul 10 16:18:48 volumio volumio[1005]: info: sendMpdCommand play took 9 milliseconds Jul 10 16:18:48 volumio volumio[1005]: info: Jul 10 16:18:48 volumio volumio[1005]: ---------------------------- MPD announces state update: player Jul 10 16:18:48 volumio volumio[1005]: info: ControllerMpd::getState Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Jul 10 16:18:48 volumio volumio[1005]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 16:18:48 volumio volumio[1005]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 16:18:48 volumio volumio[1005]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 16:18:48 volumio volumio[1005]: info: Jul 10 16:18:48 volumio volumio[1005]: ---------------------------- MPD announces state update: player Jul 10 16:18:48 volumio volumio[1005]: info: sendMpdCommand status took 10 milliseconds Jul 10 16:18:48 volumio volumio[1005]: info: ControllerMpd::getState Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::parseState Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 16:18:48 volumio volumio[1005]: info: sendMpdCommand status took 12 milliseconds Jul 10 16:18:48 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 12 milliseconds Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::parseState Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Jul 10 16:18:48 volumio volumio[1005]: info: ControllerMpd::pushState Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 8986 Jul 10 16:18:48 volumio volumio[1005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":247,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":" 如果有来生","artist":"谭维维 ","album":null,"uri":"USB/500g/mp3/处理完成/谭维维 - 如果有来生.flac","trackType":"flac"} Jul 10 16:18:48 volumio volumio[1005]: verbose: CURRENT POSITION 8986 Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::syncState stateService play Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus stop Jul 10 16:18:48 volumio volumio[1005]: info: ------------------------------ 30ms Jul 10 16:18:48 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 10 16:18:48 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Jul 10 16:18:48 volumio volumio[1005]: info: ControllerMpd::pushState Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 8986 Jul 10 16:18:48 volumio volumio[1005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":247,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1153 Kbps","isStreaming":false,"title":" 如果有来生","artist":"谭维维 ","album":null,"uri":"USB/500g/mp3/处理完成/谭维维 - 如果有来生.flac","trackType":"flac"} Jul 10 16:18:48 volumio volumio[1005]: verbose: CURRENT POSITION 8986 Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::syncState stateService play Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus play Jul 10 16:18:48 volumio volumio[1005]: info: Received an update from plugin. extracting info from payload Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 8986 Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:48 volumio volumio[1005]: info: CoreStateMachine::pushState Jul 10 16:18:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 8986 Jul 10 16:18:48 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Jul 10 16:18:48 volumio volumio[1005]: info: ------------------------------ 36ms Jul 10 16:18:48 volumio volumio[1005]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 10 16:19:09 volumio volumio[1005]: Searching all installed plugins Jul 10 16:19:09 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 10 16:19:09 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: , search Jul 10 16:19:09 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 10 16:19:09 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jul 10 16:19:09 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jul 10 16:19:09 volumio volumio[1005]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jul 10 16:19:09 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jul 10 16:19:11 volumio volumio[1005]: (node:1005) UnhandledPromiseRejectionWarning: Error: Start tag expected, '<' not found Jul 10 16:19:11 volumio volumio[1005]: at Object.module.exports.fromXml (/volumio/node_modules/libxmljs/lib/document.js:168:21) Jul 10 16:19:11 volumio volumio[1005]: at /volumio/app/plugins/music_service/webradio/index.js:949:31 Jul 10 16:19:11 volumio volumio[1005]: at runMicrotasks () Jul 10 16:19:11 volumio volumio[1005]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Jul 10 16:19:11 volumio volumio[1005]: (Use `node --trace-warnings ...` to show where the warning was created) Jul 10 16:19:11 volumio volumio[1005]: (node:1005) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 1) Jul 10 16:19:11 volumio volumio[1005]: (node:1005) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Jul 10 16:19:13 volumio volumio[1005]: Searching all installed plugins Jul 10 16:19:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 10 16:19:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: , search Jul 10 16:19:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 10 16:19:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jul 10 16:19:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jul 10 16:19:13 volumio volumio[1005]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jul 10 16:19:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jul 10 16:19:14 volumio volumio[1005]: error: Search in plugin webradio timed out Jul 10 16:19:14 volumio volumio[1005]: info: All search sources collected, pushing search results Jul 10 16:19:17 volumio volumio[1005]: info: All search sources collected, pushing search results Jul 10 16:19:22 volumio volumio[1005]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 16:19:22 volumio volumio[1005]: Error: Client network socket disconnected before secure TLS connection was established Jul 10 16:19:22 volumio volumio[1005]: at connResetException (internal/errors.js:639:14) Jul 10 16:19:22 volumio volumio[1005]: at TLSSocket.onConnectEnd (_tls_wrap.js:1570:19) Jul 10 16:19:22 volumio volumio[1005]: at TLSSocket.emit (events.js:412:35) Jul 10 16:19:22 volumio volumio[1005]: at endReadableNT (internal/streams/readable.js:1333:12) Jul 10 16:19:22 volumio volumio[1005]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Jul 10 16:19:22 volumio volumio[1005]: code: 'ECONNRESET', Jul 10 16:19:22 volumio volumio[1005]: path: null, Jul 10 16:19:22 volumio volumio[1005]: host: 'lastfm.freetls.fastly.net', Jul 10 16:19:22 volumio volumio[1005]: port: 443, Jul 10 16:19:22 volumio volumio[1005]: localAddress: undefined Jul 10 16:19:22 volumio volumio[1005]: } Jul 10 16:19:22 volumio volumio[1005]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 16:19:22 volumio sudo[6546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-10 16:18 Jul 10 16:19:22 volumio sudo[6546]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"