-- Logs begin at Fri 2025-05-30 07:23:02 UTC, end at Fri 2025-05-30 08:00:54 UTC. -- May 30 07:59:06 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:06 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:06 ifi-phmidsd-idsd-phantom volumio[2516]: info: Prefetching next song May 30 07:59:06 ifi-phmidsd-idsd-phantom volumio[2516]: info: DOING PREFETCH IN MPD May 30 07:59:06 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand add "NAS/F/(384kHz)Divertimento 382.flac" May 30 07:59:06 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:06 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces system playlist update May 30 07:59:06 ifi-phmidsd-idsd-phantom volumio[2516]: info: Ignoring MPD Status Update May 30 07:59:06 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand add "NAS/F/(384kHz)Divertimento 382.flac" took 5 milliseconds May 30 07:59:06 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand consume 1 May 30 07:59:06 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 7ms May 30 07:59:06 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand consume 1 took 4 milliseconds May 30 07:59:08 ifi-phmidsd-idsd-phantom ethernet-detect[461]: No change in avahi-daemon interfaces. Skipping restart. May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::startPlaybackTimer May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: error: Could not retrieve plugin miscellanea metavolumio May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces system playlist update May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: Ignoring MPD Status Update May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces state update: player May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::getState May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand status May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 9ms May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand status took 6 milliseconds May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseState May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioGetState May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand playlistinfo took 5 milliseconds May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseTrackInfo May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::pushState May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::servicePushState May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: STATE SERVICE {"status":"play","position":0,"seek":99,"duration":183,"samplerate":"384 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"8959 Kbps","isStreaming":false,"title":"03 - Divertimento 384","artist":null,"album":null,"uri":"NAS/F/(384kHz)Divertimento 382.flac","trackType":"flac"} May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: CURRENT POSITION 0 May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState stateService play May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState currentStatus play May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: Received an update from plugin. extracting info from payload May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:11 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:12 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 84ms May 30 07:59:12 ifi-phmidsd-idsd-phantom volumio[2516]: info: MetaClient: Sent Meta May 30 07:59:12 ifi-phmidsd-idsd-phantom volumio[2516]: info: MetaClient: Get message: success May 30 07:59:18 ifi-phmidsd-idsd-phantom ethernet-detect[461]: No change in avahi-daemon interfaces. Skipping restart. May 30 07:59:29 ifi-phmidsd-idsd-phantom ethernet-detect[461]: No change in avahi-daemon interfaces. Skipping restart. May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: ++++--++++ playItemsList: {"item":{"service":"mpd","type":"song","title":"03 - Divertimento 384","artist":"","album":"","albumart":"http://http://192.168.31.33/albumart?cacheid=606&web=//extralarge&path=%2Fmnt%2FNAS%2FF&icon=fa-tags&metadata=false","uri":"mnt/NAS/F/(384kHz)Divertimento 382.flac","id":"id-mbai3o04vktxmqlcb"},"list":[{"service":"mpd","type":"song","title":"03 - Divertimento 384","artist":"","album":"","albumart":"http://http://192.168.31.33/albumart?cacheid=606&web=//extralarge&path=%2Fmnt%2FNAS%2FF&icon=fa-tags&metadata=false","uri":"mnt/NAS/F/(384kHz)Divertimento 382.flac","id":"id-mbai3o04vktxmqlcb"}],"index":0} May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: Preload queue cleared May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioAddQueueItems May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::addQueueItems May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::addQueueItems May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: Preload queue cleared May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: Adding Item to queue: mnt/NAS/F/(384kHz)Divertimento 382.flac May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: Using cached record of: mnt/NAS/F/(384kHz)Divertimento 382.flac May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushQueue May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::saveQueue May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::updateTrackBlock May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrackBlock May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: ConvSwitch: Sent Play May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPlay May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::play index 0 May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::setConsumeUpdateService undefined May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::stop May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::setConsumeUpdateService undefined May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::stPlaybackTimer May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::updateTrackBlock May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrackBlock May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::serviceStop May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::serviceStop May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::stop May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand stop May 30 07:59:29 ifi-phmidsd-idsd-phantom volumio[2516]: info: ConvSwitch: Get message: success May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces state update: player May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand stop took 38 milliseconds May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::getState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand status May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::play index undefined May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::setConsumeUpdateService undefined May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::startPlaybackTimer May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: error: Could not retrieve plugin miscellanea metavolumio May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::clearAddPlayTracks NAS/F/(384kHz)Divertimento 382.flac May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand stop May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand status took 9 milliseconds May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand stop took 4 milliseconds May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioGetState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand clear May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces system playlist update May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: Ignoring MPD Status Update May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand playlistinfo took 5 milliseconds May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand clear took 6 milliseconds May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseTrackInfo May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand add "NAS/F/(384kHz)Divertimento 382.flac" May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::pushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::servicePushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: 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":"03 - Divertimento 384","artist":null,"album":null,"uri":"NAS/F/(384kHz)Divertimento 382.flac","trackType":"flac"} May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: CURRENT POSITION 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState stateService stop May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState currentStatus stop May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: No code May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 96ms May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: error: updateQueue error: null May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces system playlist update May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: Ignoring MPD Status Update May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 81ms May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand add "NAS/F/(384kHz)Divertimento 382.flac" took 76 milliseconds May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand play May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 12ms May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand play took 9 milliseconds May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces state update: player May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::getState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand status May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces state update: player May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand status took 30 milliseconds May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::getState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand status May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioGetState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand status took 6 milliseconds May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand playlistinfo took 4 milliseconds May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioGetState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseTrackInfo May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::pushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::servicePushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"384 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 - Divertimento 384","artist":null,"album":null,"uri":"NAS/F/(384kHz)Divertimento 382.flac","trackType":"flac"} May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: CURRENT POSITION 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState stateService play May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState currentStatus stop May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 51ms May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand playlistinfo took 9 milliseconds May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseTrackInfo May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::pushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::servicePushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"384 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 - Divertimento 384","artist":null,"album":null,"uri":"NAS/F/(384kHz)Divertimento 382.flac","trackType":"flac"} May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: CURRENT POSITION 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState stateService play May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState currentStatus play May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: Received an update from plugin. extracting info from payload May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 94ms May 30 07:59:31 ifi-phmidsd-idsd-phantom volumio[2516]: info: MetaClient: Sent Meta May 30 07:59:31 ifi-phmidsd-idsd-phantom volumio[2516]: info: MetaClient: Get message: success May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: ++++--++++ playItemsList: {"item":{"service":"mpd","type":"song","title":"03 - Divertimento 384","artist":"","album":"","albumart":"http://http://192.168.31.33/albumart?cacheid=606&web=//extralarge&path=%2Fmnt%2FNAS%2FF&icon=fa-tags&metadata=false","uri":"mnt/NAS/F/(384kHz)Divertimento 382.flac","id":"id-mbai3o04vktxmqlcb"}} May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: Preload queue cleared May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioAddQueueItems May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::addQueueItems May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::addQueueItems May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: Preload queue cleared May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: Adding Item to queue: mnt/NAS/F/(384kHz)Divertimento 382.flac May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: Using cached record of: mnt/NAS/F/(384kHz)Divertimento 382.flac May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushQueue May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::saveQueue May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::updateTrackBlock May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrackBlock May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: ConvSwitch: Sent Play May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPlay May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::play index 0 May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::setConsumeUpdateService undefined May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::stop May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::setConsumeUpdateService undefined May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::stPlaybackTimer May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::updateTrackBlock May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrackBlock May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::serviceStop May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::serviceStop May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::stop May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand stop May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: ConvSwitch: Get message: success May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces state update: player May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand stop took 58 milliseconds May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::getState May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand status May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::play index undefined May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::setConsumeUpdateService undefined May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:32 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::startPlaybackTimer May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: error: Could not retrieve plugin miscellanea metavolumio May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::clearAddPlayTracks NAS/F/(384kHz)Divertimento 382.flac May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand stop May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand status took 8 milliseconds May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand stop took 2 milliseconds May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioGetState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand clear May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces system playlist update May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: Ignoring MPD Status Update May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand playlistinfo took 6 milliseconds May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand clear took 7 milliseconds May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseTrackInfo May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand add "NAS/F/(384kHz)Divertimento 382.flac" May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::pushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::servicePushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: 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":"03 - Divertimento 384","artist":null,"album":null,"uri":"NAS/F/(384kHz)Divertimento 382.flac","trackType":"flac"} May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: CURRENT POSITION 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState stateService stop May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState currentStatus stop May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: No code May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 96ms May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: error: updateQueue error: null May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces system playlist update May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: Ignoring MPD Status Update May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 83ms May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand add "NAS/F/(384kHz)Divertimento 382.flac" took 78 milliseconds May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand play May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 10ms May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand play took 7 milliseconds May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces state update: player May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::getState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand status May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: ---------------------------- MPD announces state update: player May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand status took 8 milliseconds May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::getState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand status May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioGetState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand status took 8 milliseconds May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand playlistinfo took 5 milliseconds May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioGetState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseTrackInfo May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::pushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::servicePushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"384 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 - Divertimento 384","artist":null,"album":null,"uri":"NAS/F/(384kHz)Divertimento 382.flac","trackType":"flac"} May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: CURRENT POSITION 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState stateService play May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState currentStatus stop May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 31ms May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: sendMpdCommand playlistinfo took 10 milliseconds May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: ControllerMpd::parseTrackInfo May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: ControllerMpd::pushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::servicePushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"384 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 - Divertimento 384","artist":null,"album":null,"uri":"NAS/F/(384kHz)Divertimento 382.flac","trackType":"flac"} May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: verbose: CURRENT POSITION 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState stateService play May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::syncState currentStatus play May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: Received an update from plugin. extracting info from payload May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::pushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::getTrack 0 May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioPushState May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:59:33 ifi-phmidsd-idsd-phantom volumio[2516]: info: ------------------------------ 97ms May 30 07:59:34 ifi-phmidsd-idsd-phantom volumio[2516]: info: MetaClient: Sent Meta May 30 07:59:34 ifi-phmidsd-idsd-phantom volumio[2516]: info: MetaClient: Get message: success May 30 07:59:37 ifi-phmidsd-idsd-phantom volumiologrotate[447]: ls: cannot access '/var/log/samba/log.wb-IDSD': No such file or directory May 30 07:59:37 ifi-phmidsd-idsd-phantom volumiologrotate[447]: ls: cannot access 'PHANTOM-黎': No such file or directory May 30 07:59:39 ifi-phmidsd-idsd-phantom ethernet-detect[461]: No change in avahi-daemon interfaces. Skipping restart. May 30 07:59:49 ifi-phmidsd-idsd-phantom ethernet-detect[461]: No change in avahi-daemon interfaces. Skipping restart. May 30 07:59:59 ifi-phmidsd-idsd-phantom ethernet-detect[461]: No change in avahi-daemon interfaces. Skipping restart. May 30 08:00:09 ifi-phmidsd-idsd-phantom ethernet-detect[461]: No change in avahi-daemon interfaces. Skipping restart. May 30 08:00:19 ifi-phmidsd-idsd-phantom ethernet-detect[461]: No change in avahi-daemon interfaces. Skipping restart. May 30 08:00:28 ifi-phmidsd-idsd-phantom volumio[2516]: info: ++++--++++ browseLibrary: {"uri":"favourites"} May 30 08:00:28 ifi-phmidsd-idsd-phantom volumio[2516]: info: Preload queue cleared May 30 08:00:30 ifi-phmidsd-idsd-phantom ethernet-detect[461]: No change in avahi-daemon interfaces. Skipping restart. May 30 08:00:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: ++++--++++ browseLibrary: {"uri":"favourites"} May 30 08:00:30 ifi-phmidsd-idsd-phantom volumio[2516]: info: Preload queue cleared May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: info: ++++--++++ addToQueue: null May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreCommandRouter::volumioAddQueueItems May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: info: CoreStateMachine::addQueueItems May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: info: CorePlayQueue::addQueueItems May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: info: Preload queue cleared May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: TypeError: Cannot read property 'uri' of null May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:221:14) May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:251:25) May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: at CoreCommandRouter.addQueueItems (/volumio/app/index.js:530:28) May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:87:26) May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: at Socket.emit (events.js:400:28) May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: at processTicksAndRejections (internal/process/task_queues.js:77:11) May 30 08:00:34 ifi-phmidsd-idsd-phantom volumio[2516]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 08:00:35 ifi-phmidsd-idsd-phantom sudo[8457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-30 07:59 May 30 08:00:35 ifi-phmidsd-idsd-phantom sudo[8457]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:35 ifi-phmidsd-idsd-phantom sudo[8457]: pam_unix(sudo:session): session closed for user root May 30 08:00:37 ifi-phmidsd-idsd-phantom volumio-remote-updater[449]: [2025-05-30 08:00:37] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 30 08:00:37 ifi-phmidsd-idsd-phantom volumio-remote-updater[449]: [2025-05-30 08:00:37] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 30 08:00:37 ifi-phmidsd-idsd-phantom node[439]: Closing connection with the client volumio May 30 08:00:37 ifi-phmidsd-idsd-phantom node[434]: ConvSwitch: Drop client volumio May 30 08:00:37 ifi-phmidsd-idsd-phantom systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 30 08:00:37 ifi-phmidsd-idsd-phantom systemd[1]: volumio.service: Failed with result 'exit-code'. May 30 08:00:37 ifi-phmidsd-idsd-phantom systemd[1]: Started dynamicswap service. May 30 08:00:37 ifi-phmidsd-idsd-phantom systemd[1]: dynamicswap.service: Succeeded. May 30 08:00:37 ifi-phmidsd-idsd-phantom systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 30 08:00:37 ifi-phmidsd-idsd-phantom systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. May 30 08:00:37 ifi-phmidsd-idsd-phantom systemd[1]: Stopped Volumio Backend Module. May 30 08:00:37 ifi-phmidsd-idsd-phantom systemd[1]: Started Volumio Backend Module. May 30 08:00:37 ifi-phmidsd-idsd-phantom systemd[1]: Started dynamicswap service. May 30 08:00:37 ifi-phmidsd-idsd-phantom systemd[1]: dynamicswap.service: Succeeded. May 30 08:00:38 ifi-phmidsd-idsd-phantom volumiologrotate[447]: ls: cannot access '/var/log/samba/log.wb-IDSD': No such file or directory May 30 08:00:38 ifi-phmidsd-idsd-phantom volumiologrotate[447]: ls: cannot access 'PHANTOM-黎': No such file or directory May 30 08:00:40 ifi-phmidsd-idsd-phantom ethernet-detect[461]: No change in avahi-daemon interfaces. Skipping restart. May 30 08:00:40 ifi-phmidsd-idsd-phantom volumio[8524]: info: ------------------------------------------- May 30 08:00:40 ifi-phmidsd-idsd-phantom volumio[8524]: info: ----- Volumio3 ---- May 30 08:00:40 ifi-phmidsd-idsd-phantom volumio[8524]: info: ------------------------------------------- May 30 08:00:40 ifi-phmidsd-idsd-phantom volumio[8524]: info: ----- System startup ---- May 30 08:00:40 ifi-phmidsd-idsd-phantom volumio[8524]: info: ------------------------------------------- May 30 08:00:40 ifi-phmidsd-idsd-phantom volumio[8524]: info: ConvSwitch: Client Start May 30 08:00:40 ifi-phmidsd-idsd-phantom volumio[8524]: info: MetaClient: Client Start May 30 08:00:40 ifi-phmidsd-idsd-phantom node[439]: A new connection has been established. May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Plugin folders cleanup May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Scanning into folder /volumio/app/plugins/ May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Scanning category audio_interface May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Scanning category miscellanea May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Scanning category music_service May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Scanning category plugins.json May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Scanning category system_controller May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Scanning category user_interface May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Scanning into folder /data/plugins/ May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Scanning category .git May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Scanning category music_service May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Plugin folders cleanup completed May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: ------------------------------------------- May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: ----- Core plugins startup ---- May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: ------------------------------------------- May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugins from folder /volumio/app/plugins/ May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Adding plugin networkaudiod to MyMusic Plugins May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Adding plugin qobuz_connect to MyMusic Plugins May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Adding plugin spotify_connect to MyMusic Plugins May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Adding plugin tidal_connect to MyMusic Plugins May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Adding plugin upnp to MyMusic Plugins May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Adding plugin airplay1_switch to MyMusic Plugins May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Adding plugin airplay2_switch to MyMusic Plugins May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Adding plugin roon_ready to MyMusic Plugins May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Adding plugin upnp_browser to MyMusic Plugins May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugins from folder /data/plugins/ May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "system"... May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "appearance"... May 30 08:00:42 ifi-phmidsd-idsd-phantom volumio-remote-updater[449]: [2025-05-30 08:00:42] [connect] Successful connection May 30 08:00:43 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "network"... May 30 08:00:43 ifi-phmidsd-idsd-phantom volumio[8524]: info: Refreshing Cached IP Addresses May 30 08:00:43 ifi-phmidsd-idsd-phantom sudo[8727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 30 08:00:43 ifi-phmidsd-idsd-phantom sudo[8727]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:43 ifi-phmidsd-idsd-phantom sudo[8729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 30 08:00:43 ifi-phmidsd-idsd-phantom sudo[8729]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:43 ifi-phmidsd-idsd-phantom sudo[8727]: pam_unix(sudo:session): session closed for user root May 30 08:00:43 ifi-phmidsd-idsd-phantom sudo[8729]: pam_unix(sudo:session): session closed for user root May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "services"... May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "alsa_controller"... May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8738]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "wizard"... May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "networkfs"... May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Cannot mount NAS F at system boot, trial number 1 ,retrying in 5 seconds May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.10/Music\testmusic /mnt/NAS/testMusic May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8753]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.10/Music\testmusic /mnt/NAS/testnas May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8755]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: Status code returned 0xc000006d NT_STATUS_LOGON_FAILURE May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: CIFS VFS: Send error in SessSetup = -13 May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: CIFS VFS: cifs_mount failed w/return code = -13 May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8753]: pam_unix(sudo:session): session closed for user root May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.10/Music\testmusic /mnt/NAS/A May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8758]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: Status code returned 0xc000006d NT_STATUS_LOGON_FAILURE May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: CIFS VFS: Send error in SessSetup = -13 May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: CIFS VFS: cifs_mount failed w/return code = -13 May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8755]: pam_unix(sudo:session): session closed for user root May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: Status code returned 0xc000006d NT_STATUS_LOGON_FAILURE May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: CIFS VFS: Send error in SessSetup = -13 May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: CIFS VFS: cifs_mount failed w/return code = -13 May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Cannot mount NAS D at system boot, trial number 1 ,retrying in 5 seconds May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Cannot mount NAS TS at system boot, trial number 1 ,retrying in 5 seconds May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8738]: pam_unix(sudo:session): session closed for user root May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8758]: pam_unix(sudo:session): session closed for user root May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Starting Udev Watcher for removable devices May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.10/Music\testmusic /mnt/NAS/B May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8766]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.10/Music\testmusic /mnt/NAS/C May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8771]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: error: Cannot associate FS Label, not mounting May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: error: Cannot associate FS Label, not mounting May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: Status code returned 0xc000006d NT_STATUS_LOGON_FAILURE May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: CIFS VFS: Send error in SessSetup = -13 May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: CIFS VFS: cifs_mount failed w/return code = -13 May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8766]: pam_unix(sudo:session): session closed for user root May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: Status code returned 0xc000006d NT_STATUS_LOGON_FAILURE May 30 08:00:44 ifi-phmidsd-idsd-phantom kernel: CIFS VFS: Send error in SessSetup = -13 May 30 08:00:44 ifi-phmidsd-idsd-phantom sudo[8771]: pam_unix(sudo:session): session closed for user root May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Ignoring mount for partition: BOOT May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Ignoring mount for partition: archivefs May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Ignoring mount for partition: rootfs May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "volumio_command_line_client"... May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Plugin networkaudiod is not enabled May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "tidal_connect"... May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: [1748592044570] Starting Tidal Connect Service May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "upnp"... May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: [1748592044585] Starting Upmpd Daemon May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Starting Upmpd Daemon May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: error: ATTENTION!!!: Plugin upnp does not return adequate promise from onVolumioStart: please update! May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "my_music"... May 30 08:00:44 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "mpd"... May 30 08:00:45 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "upnp_browser"... May 30 08:00:45 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "qobuz_connect"... May 30 08:00:45 ifi-phmidsd-idsd-phantom volumio[8524]: info: [1748592045679] Starting Qobuz Connect Service May 30 08:00:45 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "alarm-clock"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Alarm: Scheduling Playlist 新建歌单 at 20:0 May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "last_100"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "roon_ready"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Starting RoonReady Sync May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "webradio"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "i2s_dacs"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: I2S DAC not set, start Auto-detection May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "volumiodiscovery"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: *** WARNING *** Please fix your application to use the native API of Avahi! May 30 08:00:46 ifi-phmidsd-idsd-phantom node[8524]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: *** WARNING *** For more information see May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: *** WARNING *** Please fix your application to use the native API of Avahi! May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: *** WARNING *** For more information see May 30 08:00:46 ifi-phmidsd-idsd-phantom node[8524]: *** WARNING *** Please fix your application to use the native API of Avahi! May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Applying required configuration parameters for plugin volumiodiscovery May 30 08:00:46 ifi-phmidsd-idsd-phantom node[8524]: *** WARNING *** For more information see May 30 08:00:46 ifi-phmidsd-idsd-phantom node[8524]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 30 08:00:46 ifi-phmidsd-idsd-phantom node[8524]: *** WARNING *** Please fix your application to use the native API of Avahi! May 30 08:00:46 ifi-phmidsd-idsd-phantom node[8524]: *** WARNING *** For more information see May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Discovery: Started advertising with name: iDSD PHANTOM-黎 May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "spotify_connect"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: [1748592046366] Starting Spotify Connect Service May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Plugin airplay1_switch is not enabled May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "airplay2_switch"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "airplay_emulation"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Starting Shairport Sync May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "outputs"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "albumart"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Plugin example_plugin is not enabled May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "inputs"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "updater_comm"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Plugin mpdemulation is not enabled May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "rest_api"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading plugin "websocket"... May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Starting Socket.io Server version 2.3.0 May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Plugin cdplayer is not enabled May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: Loading i18n strings for locale zh May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: Updating browse sources language May 30 08:00:46 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: Forking 3 albumart workers May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::initPlayerControls May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: Removing existing socket file at /tmp/meta.sock May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: Express server listening on port 3000 May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: [Metrics] WebUI: 7s 855.29ms May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreStateMachine::resetVolumioState May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreStateMachine::getcurrentVolume May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::volumioRetrievevolume May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: Meta server listening May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreStateMachine::pushState May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CorePlayQueue::getTrack 0 May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::volumioPushState May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: Server listening on port 6599 May 30 08:00:47 ifi-phmidsd-idsd-phantom sudo[8900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service May 30 08:00:47 ifi-phmidsd-idsd-phantom sudo[8900]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: Completed loading Core Plugins May 30 08:00:47 ifi-phmidsd-idsd-phantom volumio[8524]: info: Preparing to generate the ALSA configuration file May 30 08:00:47 ifi-phmidsd-idsd-phantom sudo[8902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service May 30 08:00:47 ifi-phmidsd-idsd-phantom sudo[8902]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:47 ifi-phmidsd-idsd-phantom node[439]: Closing connection with the client tidal-connect May 30 08:00:47 ifi-phmidsd-idsd-phantom systemd[1]: Stopping iFi Streamer Tidal Metadata Service... May 30 08:00:47 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM May 30 08:00:47 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. May 30 08:00:47 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Tidal Metadata Service. May 30 08:00:48 ifi-phmidsd-idsd-phantom systemd[1]: Stopping iFi Streamer Tidal Connect Service... May 30 08:00:48 ifi-phmidsd-idsd-phantom node[434]: ConvSwitch: Drop client tidal May 30 08:00:48 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM May 30 08:00:48 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. May 30 08:00:48 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Tidal Connect Service. May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: ConvSwitch: Connected to server May 30 08:00:48 ifi-phmidsd-idsd-phantom node[434]: ConvSwitch: Add client volumio May 30 08:00:48 ifi-phmidsd-idsd-phantom sudo[8902]: pam_unix(sudo:session): session closed for user root May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: MetaClient: Connected to server May 30 08:00:48 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Tidal Connect Service. May 30 08:00:48 ifi-phmidsd-idsd-phantom sudo[8900]: pam_unix(sudo:session): session closed for user root May 30 08:00:48 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Tidal Metadata Service. May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: Volumio Network Manager: Network status updated: 2 May 30 08:00:48 ifi-phmidsd-idsd-phantom node[439]: A new connection has been established. May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: Cannot mount NAS C at system boot, trial number 1 ,retrying in 5 seconds May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: Cannot mount NAS B at system boot, trial number 1 ,retrying in 5 seconds May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: Cannot mount NAS A at system boot, trial number 1 ,retrying in 5 seconds May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: Cannot mount NAS testnas at system boot, trial number 1 ,retrying in 5 seconds May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: Cannot mount NAS testMusic at system boot, trial number 1 ,retrying in 5 seconds May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: ConvSwitch: Get message: success May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: MetaClient: Get message: success May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: verbose: New Socket.io Connection to 192.168.31.33 from 192.168.31.249 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: verbose: New Socket.io Connection to 192.168.31.33 from 192.168.31.249 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: verbose: New Socket.io Connection to 192.168.31.33 from 192.168.31.121 UA: okhttp/3.12.11 Engine version: 3 Transport: websocket Total Clients: 3 May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: verbose: New Socket.io Connection to 192.168.31.33:3000 from 192.168.31.174 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: verbose: New Socket.io Connection to 192.168.31.33 from 192.168.31.249 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: verbose: New Socket.io Connection to 192.168.31.33:3000 from 192.168.31.174 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: verbose: New Socket.io Connection to 192.168.31.33 from 192.168.31.121 UA: okhttp/3.12.11 Engine version: 3 Transport: websocket Total Clients: 7 May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: Tidal Connect Service Started May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: Qobuz Connect Service Started May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: ++++--++++ getState May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::volumioGetState May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: CorePlayQueue::getTrack 0 May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: ++++--++++ getQueue May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::volumioGetQueue May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreStateMachine::getQueue May 30 08:00:48 ifi-phmidsd-idsd-phantom volumio[8524]: info: CorePlayQueue::getQueue May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: Reloading queue from file May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: ++++--++++ getBrowseSources: undefined May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::volumioGetVisibleSources May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: ++++--++++ getUiConfig: {"page":"system_controller/system"} May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::getUIConfigOnPlugin May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: ++++--++++ getMenuItems May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: ++++--++++ getMultiRoomDevices: null May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: ++++--++++ browseLibrary: {"uri":"favourites"} May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: Starting albumart workers May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: ++++--++++ initSocket: {"id":"f34eb979-6245-494d-bcae-a21e70b78195"} May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: Cannot mount NAS F at system boot, trial number 2 ,retrying in 5 seconds May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreStateMachine::setRepeat true single undefined May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreStateMachine::pushState May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CorePlayQueue::getTrack 0 May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::volumioPushState May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreStateMachine::setRandom null May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreStateMachine::pushState May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CorePlayQueue::getTrack 0 May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::volumioPushState May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: Starting albumart workers May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: Cannot mount NAS D at system boot, trial number 2 ,retrying in 5 seconds May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: Cannot mount NAS TS at system boot, trial number 2 ,retrying in 5 seconds May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: Asound.conf file unchanged, so no further update is needed May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: Tidal connect: Output device has changed May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: Output device has changed, restarting MPD May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: Qobuz connect: Output device has changed May 30 08:00:49 ifi-phmidsd-idsd-phantom sudo[8951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service May 30 08:00:49 ifi-phmidsd-idsd-phantom sudo[8951]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: Roon Ready: Output device has changed May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: Spotify: Output device has changed May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: ___________ START PLUGINS ___________ May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: ControllerMpd::onStart: Initializing MPD May 30 08:00:49 ifi-phmidsd-idsd-phantom sudo[8959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: Creating MPD Configuration file May 30 08:00:49 ifi-phmidsd-idsd-phantom play[3037]: 2025-05-30 08:00:49.676 E esdk select error: 4 -> Interrupted system call May 30 08:00:49 ifi-phmidsd-idsd-phantom play[3037]: 2025-05-30 08:00:49.677 I app Exiting with error = 0 May 30 08:00:49 ifi-phmidsd-idsd-phantom play[3037]: 2025-05-30 08:00:49.677 I api SpFree() May 30 08:00:49 ifi-phmidsd-idsd-phantom play[3037]: 2025-05-30 08:00:49.684 I api SpFree [returned value: 0] May 30 08:00:49 ifi-phmidsd-idsd-phantom play[3037]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 May 30 08:00:49 ifi-phmidsd-idsd-phantom play[3037]: [Info] ConvSwitch: ConvSwitchInit May 30 08:00:49 ifi-phmidsd-idsd-phantom play[3037]: [Info] MetaClient: MetaClient SDK -- v1.02 May 30 08:00:49 ifi-phmidsd-idsd-phantom play[3037]: [Info] MetaClient: MetaClientInit May 30 08:00:49 ifi-phmidsd-idsd-phantom play[3037]: [Info] ConvSwitch: ConvSwitchExit May 30 08:00:49 ifi-phmidsd-idsd-phantom play[3037]: [Info] MetaClient: MetaClientExit May 30 08:00:49 ifi-phmidsd-idsd-phantom node[439]: Closing connection with the client spotify May 30 08:00:49 ifi-phmidsd-idsd-phantom node[434]: ConvSwitch: Drop client spotify May 30 08:00:49 ifi-phmidsd-idsd-phantom systemd[1]: Stopping iFi Streamer Spotify Connect Service... May 30 08:00:49 ifi-phmidsd-idsd-phantom sudo[8959]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:49 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM May 30 08:00:49 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. May 30 08:00:49 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Spotify Connect Service. May 30 08:00:49 ifi-phmidsd-idsd-phantom sudo[8959]: pam_unix(sudo:session): session closed for user root May 30 08:00:49 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Spotify Connect Service. May 30 08:00:49 ifi-phmidsd-idsd-phantom sudo[8951]: pam_unix(sudo:session): session closed for user root May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 30 08:00:49 ifi-phmidsd-idsd-phantom sudo[8965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: [1748592049845] CoreMusicLibrary::Adding element 媒体服务器 May 30 08:00:49 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 30 08:00:49 ifi-phmidsd-idsd-phantom sudo[8965]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:49 ifi-phmidsd-idsd-phantom sudo[8965]: pam_unix(sudo:session): session closed for user root May 30 08:00:49 ifi-phmidsd-idsd-phantom sudo[8970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service May 30 08:00:49 ifi-phmidsd-idsd-phantom sudo[8970]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: output: volumio mixer: hw:0 May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: [1748592050058] CoreMusicLibrary::Adding element Last_100 May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 30 08:00:50 ifi-phmidsd-idsd-phantom systemd[1]: Stopping Music Player Daemon... May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: Starting RoonReady Sync May 30 08:00:50 ifi-phmidsd-idsd-phantom node[434]: ConvSwitch: Add client spotify May 30 08:00:50 ifi-phmidsd-idsd-phantom node[439]: A new connection has been established. May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: [1748592050134] CoreMusicLibrary::Adding element Webradio May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.167 I api SpRegisterDebugCallbacks [returned value: 0] May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.168 I api SpInit(0xffe52630, API v66) May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.168 I esdk eSDK version: HEAD-v3.166.69-g24821f73 May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.168 I esdk Successfully registered socket callbacks: cre, set_opt, cl, bind, list, con, acc, rd, wr, rd_from, wr_to, err, readable, writable, local_addresses, address, pump May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.169 I esdk Successfully registered dns callback: dns_lookup_callback May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.169 I download Using 128 kB for cache buffer May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.169 I download Using 621 kB for compressed audio buffer May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.169 I esdk Successfully registered error callback May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: Initializing BBC Radios May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.200 I esdk Creating IPv4 socket (domain 2) May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.201 I zc webserver: service port 5566 (5566-5576) buffer size 4444 May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.201 I zc Started ZeroConf service on port 5566 path /zc alias count 0 May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.201 I esdk Creating IPv4 socket (domain 2) May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.201 I api SpInit [returned value: 0] May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.202 I api SpRegisterConnectionCallbacks(0xffe52618, (nil)) May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.202 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.202 I api SpRegisterConnectionCallbacks [returned value: 0] May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.202 I api SpRegisterPlaybackCallbacks(0xffe52600, (nil)) May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.202 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.202 I api SpRegisterPlaybackCallbacks [returned value: 0] May 30 08:00:50 ifi-phmidsd-idsd-phantom sudo[8984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.223 W app Couldn't find mixer for volume controls. (tried , SoftMaster) May 30 08:00:50 ifi-phmidsd-idsd-phantom play[8964]: 2025-05-30 08:00:50.223 I app Initialized! May 30 08:00:50 ifi-phmidsd-idsd-phantom sudo[8984]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:50 ifi-phmidsd-idsd-phantom systemd[1]: mpd.service: Succeeded. May 30 08:00:50 ifi-phmidsd-idsd-phantom systemd[1]: Stopped Music Player Daemon. May 30 08:00:50 ifi-phmidsd-idsd-phantom node[439]: Closing connection with the client roon-ready May 30 08:00:50 ifi-phmidsd-idsd-phantom node[434]: ConvSwitch: Drop client roon-ready May 30 08:00:50 ifi-phmidsd-idsd-phantom systemd[1]: Stopping iFi Streamer Roon Ready Service... May 30 08:00:50 ifi-phmidsd-idsd-phantom systemd[1]: mpd.socket: Succeeded. May 30 08:00:50 ifi-phmidsd-idsd-phantom systemd[1]: Closed mpd.socket. May 30 08:00:50 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM May 30 08:00:50 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Succeeded. May 30 08:00:50 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. May 30 08:00:50 ifi-phmidsd-idsd-phantom demo[746]: MPD error: Connection refused May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 08:00:50 ifi-phmidsd-idsd-phantom demo[746]: MPD error: Connection refused May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 08:00:50 ifi-phmidsd-idsd-phantom demo[746]: MPD error: Connection refused May 30 08:00:50 ifi-phmidsd-idsd-phantom ethernet-detect[461]: No change in avahi-daemon interfaces. Skipping restart. May 30 08:00:50 ifi-phmidsd-idsd-phantom sudo[8970]: pam_unix(sudo:session): session closed for user root May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom demo[746]: MPD error: Connection refused May 30 08:00:50 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: input: iFi (by AMR) iDSD PHANTOM as /devices/platform/usb@ff600000/ff600000.dwc3/xhci-hcd.0.auto/usb4/4-1/4-1.2/4-1.2:1.4/0003:20B1:3008.0008/input/input7 May 30 08:00:50 ifi-phmidsd-idsd-phantom sudo[9040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -snf /usr/local/bin/airplay2 /usr/local/bin/shairport-sync May 30 08:00:50 ifi-phmidsd-idsd-phantom sudo[8984]: pam_unix(sudo:session): session closed for user root May 30 08:00:50 ifi-phmidsd-idsd-phantom sudo[9040]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:50 ifi-phmidsd-idsd-phantom sudo[9040]: pam_unix(sudo:session): session closed for user root May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: hid-generic 0003:20B1:3008.0008: input,hidraw0: USB HID v1.11 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input4 May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom systemd-udevd[9048]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 30 08:00:50 ifi-phmidsd-idsd-phantom volumio[8524]: info: Volumio Calling Home May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:50 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom volumio[8524]: Starting albumart workers May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom ifi_metadata[8907]: [Info] MetaClient: MetaClient SDK -- v1.02 May 30 08:00:51 ifi-phmidsd-idsd-phantom ifi_metadata[8907]: [Info] MetaClient: MetaClientInit May 30 08:00:51 ifi-phmidsd-idsd-phantom ifi_metadata[8907]: Could not connect: Reason::CONNECTION_ERROR May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom demo[746]: MPD error: Connection refused May 30 08:00:51 ifi-phmidsd-idsd-phantom demo[746]: MPD error: Connection refused May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom volumio[8524]: info: ++++--++++ getState May 30 08:00:51 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::volumioGetState May 30 08:00:51 ifi-phmidsd-idsd-phantom volumio[8524]: info: CorePlayQueue::getTrack 0 May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed May 30 08:00:51 ifi-phmidsd-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree May 30 08:00:51 ifi-phmidsd-idsd-phantom volumio[8524]: info: Starting RoonReady Sync May 30 08:00:51 ifi-phmidsd-idsd-phantom sudo[9112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service May 30 08:00:51 ifi-phmidsd-idsd-phantom sudo[9112]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:51 ifi-phmidsd-idsd-phantom play[9045]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input May 30 08:00:51 ifi-phmidsd-idsd-phantom volumio[8524]: info: Discovery: adding f34eb979-6245-494d-bcae-a21e70b78195 May 30 08:00:51 ifi-phmidsd-idsd-phantom volumio[8524]: info: Discovery: Found device iDSD PHANTOM 23 May 30 08:00:51 ifi-phmidsd-idsd-phantom sudo[9114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service May 30 08:00:51 ifi-phmidsd-idsd-phantom sudo[9114]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:51 ifi-phmidsd-idsd-phantom volumio[8524]: info: Discovery: Connecting to remote: 192.168.31.174 May 30 08:00:51 ifi-phmidsd-idsd-phantom sudo[9118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service May 30 08:00:51 ifi-phmidsd-idsd-phantom sudo[9118]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:51 ifi-phmidsd-idsd-phantom volumio[8524]: verbose: New Socket.io Connection to 192.168.31.33 from 192.168.31.249 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 May 30 08:00:51 ifi-phmidsd-idsd-phantom node[439]: Closing connection with the client qobuz-connect May 30 08:00:51 ifi-phmidsd-idsd-phantom node[434]: ConvSwitch: Drop client qobuz-connect May 30 08:00:51 ifi-phmidsd-idsd-phantom systemd[1]: Stopping iFi Streamer Qobuz Connect Service... May 30 08:00:51 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM May 30 08:00:51 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. May 30 08:00:51 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Qobuz Connect Service. May 30 08:00:51 ifi-phmidsd-idsd-phantom volumio[8524]: info: Airplay2 Started May 30 08:00:51 ifi-phmidsd-idsd-phantom volumio[8524]: error: Could not retrieve plugin music_service airplay1_switch May 30 08:00:51 ifi-phmidsd-idsd-phantom volumio[8524]: info: Disabling plugin airplay1_switch May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: Done. May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: RoonReady Started May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9112]: pam_unix(sudo:session): session closed for user root May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: MPD Permissions set May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: MPD Permissions set May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: Spotify Connect Service Started May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9130]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9135]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:52 ifi-phmidsd-idsd-phantom systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 30 08:00:52 ifi-phmidsd-idsd-phantom systemd[1]: Stopping iFi Streamer Roon Ready Service... May 30 08:00:52 ifi-phmidsd-idsd-phantom systemd[1]: shairport-sync.service: Succeeded. May 30 08:00:52 ifi-phmidsd-idsd-phantom systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 30 08:00:52 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM May 30 08:00:52 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Succeeded. May 30 08:00:52 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: Discovery: adding bd23ed3f-ba56-4c0f-8237-c1a8d2e1c588 May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: Discovery: Found device iDSD PHANTOM-黎 May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::volumioGetState May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CorePlayQueue::getTrack 0 May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: error: Could not retrieve plugin audio_interface multiroom May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9130]: pam_unix(sudo:session): session closed for user root May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9118]: pam_unix(sudo:session): session closed for user root May 30 08:00:52 ifi-phmidsd-idsd-phantom node[434]: ConvSwitch: Add client tidal May 30 08:00:52 ifi-phmidsd-idsd-phantom systemd[1]: Listening on mpd.socket. May 30 08:00:52 ifi-phmidsd-idsd-phantom systemd[1]: Starting Music Player Daemon... May 30 08:00:52 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9114]: pam_unix(sudo:session): session closed for user root May 30 08:00:52 ifi-phmidsd-idsd-phantom tidal_connect_application[9110]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. May 30 08:00:52 ifi-phmidsd-idsd-phantom tidal_connect_application[9110]: *** WARNING *** Please fix your application to use the native API of Avahi! May 30 08:00:52 ifi-phmidsd-idsd-phantom tidal_connect_application[9110]: *** WARNING *** For more information see May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: error: Could not retrieve plugin audio_interface multiroom May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: Discovery: Connected to remote: 192.168.31.174 May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: error: Could not retrieve plugin audio_interface multiroom May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: Preload queue cleared May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: Preloading song: mnt/NAS/F/(384kHz)Divertimento 382.flac May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom ifi_metadata[8907]: Connected May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9148]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9148]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9148]: pam_unix(sudo:session): session closed for user root May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: RoonReady Started May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: Volumio called home May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: Shairport-Sync Stopped May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: info: Exploding uri mnt/NAS/F/(384kHz)Divertimento 382.flac in service mpd May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service May 30 08:00:52 ifi-phmidsd-idsd-phantom sudo[9192]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: TypeError: Cannot read property 'then' of undefined May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2846:19) May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2644:21) May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1489:16) May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100) May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: at listOnTimeout (internal/timers.js:557:17) May 30 08:00:52 ifi-phmidsd-idsd-phantom volumio[8524]: at processTimers (internal/timers.js:500:7) May 30 08:00:53 ifi-phmidsd-idsd-phantom volumio[8524]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 08:00:53 ifi-phmidsd-idsd-phantom systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 30 08:00:53 ifi-phmidsd-idsd-phantom systemd[1]: mpd.service: Succeeded. May 30 08:00:53 ifi-phmidsd-idsd-phantom systemd[1]: Stopped Music Player Daemon. May 30 08:00:53 ifi-phmidsd-idsd-phantom systemd[1]: mpd.socket: Succeeded. May 30 08:00:53 ifi-phmidsd-idsd-phantom systemd[1]: Closed mpd.socket. May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: MPD error: Connection reset by peer May 30 08:00:53 ifi-phmidsd-idsd-phantom systemd[1]: Stopping mpd.socket. May 30 08:00:53 ifi-phmidsd-idsd-phantom systemd[1]: Listening on mpd.socket. May 30 08:00:53 ifi-phmidsd-idsd-phantom systemd[1]: Starting Music Player Daemon... May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: *************************************************** May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: format: DXD May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: base: 1 times: 4 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: in rate: 384000 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: base: 1 times: 4 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: out rate: 384000 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: current filter index: 0 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: current k2 index: 0 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: current dsd index: 0 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: current filter bit mask: 0x1 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: available filter bit mask: 0x19 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: current k2 bit mask: 0x1 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: available k2 bit mask: 0x1 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: current dsd remaster bit mask: 0x1 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: available dsd remaster bit mask: 0xf May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: *************************************************** May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: Status request timed out, resending May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: alsa no stream May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: [receive from xmos]: ff 05 00 04 31 01 fa 45 May 30 08:00:53 ifi-phmidsd-idsd-phantom demo[746]: CMD_XMOS_STREAM_IDLE_STATE May 30 08:00:53 ifi-phmidsd-idsd-phantom sudo[9197]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 30 08:00:53 ifi-phmidsd-idsd-phantom sudo[9197]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:53 ifi-phmidsd-idsd-phantom sudo[9197]: pam_unix(sudo:session): session closed for user root May 30 08:00:53 ifi-phmidsd-idsd-phantom play[9151]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input May 30 08:00:54 ifi-phmidsd-idsd-phantom sudo[9250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-30 07:59 May 30 08:00:54 ifi-phmidsd-idsd-phantom sudo[9250]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 08:00:54 ifi-phmidsd-idsd-phantom node[434]: ConvSwitch: Add client roon-ready 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="ea9295b1c560887e670c2b8bc42c4ae53e8db82e" VOLUMIO_FE_VERSION="0548e367fe44b194ccf1306c8af35deb040eccd2" VOLUMIO_FE3_VERSION="c63cc070c36379a8d79dc0d7d4a24908bebc2472" VOLUMIO_BE_VERSION="3726727bab178eb8efe84a1e6eb6839c18c66afb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="ifi" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="2025年 05月 26日 星期一 09:25:26 CST" VOLUMIO_VERSION="3.00.0" VOLUMIO_HARDWARE="idsd-phantom" VOLUMIO_DEVICENAME="iDSD PHANTOM" VOLUMIO_HASH="307301c484db03549c2874264db08794"