-- Logs begin at Thu 2026-04-23 08:04:08 UTC, end at Thu 2026-10-15 18:02:57 UTC. -- Oct 15 18:01:00 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:00 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:01 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:01 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:02 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:02 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:03 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:03 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:04 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:04 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:05 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:05 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:06 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:06 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:07 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:07 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:08 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:08 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:09 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:09 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:10 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:10 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:11 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:11 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:12 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:12 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:13 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:13 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:14 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:14 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:15 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:16 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:17 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:17 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:18 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:18 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:19 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:19 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:20 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:20 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:21 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:21 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:21 ifi-idsd-phantom volumiologrotate[460]: ls: cannot access '/var/log/samba/log.wb-IDSD': No such file or directory Oct 15 18:01:21 ifi-idsd-phantom volumiologrotate[460]: ls: cannot access 'PHANTOM': No such file or directory Oct 15 18:01:22 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:22 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:23 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:23 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:24 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:24 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:25 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:25 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:26 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:26 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:27 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:27 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:28 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:28 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:29 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:29 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:30 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:30 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:31 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:31 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:32 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:32 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:33 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:33 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:34 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:34 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:35 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:35 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:36 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:36 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:37 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:37 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Preload queue cleared Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::ClearQueue Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::stop Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::stPlaybackTimer Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::updateTrackBlock Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrackBlock Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::pushState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::serviceStop Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 2 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::serviceStop Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::stop Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::clearPlayQueue Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::saveQueue Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushQueue Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::addQueueItems Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::addQueueItems Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Preload queue cleared Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/卢冠廷&莫文蔚-一生所爱.wav Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/卢冠廷&莫文蔚-一生所爱.wav Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/蔡琴 - 渡口.wav Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/蔡琴 - 渡口.wav Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/04. She's So Heavy DSD 512fs - 2ch.dsf Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/04. She's So Heavy DSD 512fs - 2ch.dsf Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/08. April In Paris DSD 512fs - 2ch.dsf Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/08. April In Paris DSD 512fs - 2ch.dsf Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/10. Something Cool DSD 512fs - 2ch.dsf Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/10. Something Cool DSD 512fs - 2ch.dsf Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushQueue Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::saveQueue Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::updateTrackBlock Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrackBlock Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: ConvSwitch: Sent Play Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPlay Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::play index 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::addQueueItems Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::addQueueItems Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Preload queue cleared Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/(CD1)禅意原声 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/(CD1)禅意原声 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/张学友 -《歌神金曲珍藏》 DSD Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/张学友 -《歌神金曲珍藏》 DSD Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/张学友-真爱+真正精选 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/张学友-真爱+真正精选 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/洋澜一　2025《谁》 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/洋澜一　2025《谁》 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/碧那 - 一念归来 DSD Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/碧那 - 一念归来 DSD Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/罗文 射雕英雄传 Roman Tam - Denon Mastersonic - She Diao Ying Xiong Chuan Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/罗文 射雕英雄传 Roman Tam - Denon Mastersonic - She Diao Ying Xiong Chuan Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/运气来得若有似无 Oct 15 18:01:38 ifi-idsd-phantom ifi_metadata[23203]: Request 6 failed with result ResultCode::ILLEGAL_STATE Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/运气来得若有似无 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::stop Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::play index undefined Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::startPlaybackTimer Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: error: Could not retrieve plugin miscellanea metavolumio Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::clearAddPlayTracks USB/A0CC-7B51/10. Something Cool DSD 512fs - 2ch.dsf Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushQueue Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::saveQueue Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::updateTrackBlock Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrackBlock Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: ConvSwitch: Get message: success Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces state update: player Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand stop took 163 milliseconds Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::getState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand status Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand stop took 75 milliseconds Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand clear Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces system playlist update Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Ignoring MPD Status Update Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand status took 21 milliseconds Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand clear took 18 milliseconds Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand add "USB/A0CC-7B51/10. Something Cool DSD 512fs - 2ch.dsf" Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: error: updateQueue error: null Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 21ms Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseTrackInfo Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 50ms Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces system playlist update Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Ignoring MPD Status Update Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand add "USB/A0CC-7B51/10. Something Cool DSD 512fs - 2ch.dsf" took 20 milliseconds Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand play Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 10ms Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand play took 8 milliseconds Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces state update: player Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::getState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand status Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand status took 20 milliseconds Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces state update: player Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::getState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand status Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseTrackInfo Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::pushState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::servicePushState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":367,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10. Something Cool DSD 512fs - 2ch.dsf","artist":"Various Artists","album":"TRUE AUDIOPHILE: Best Of Groove Note","uri":"USB/A0CC-7B51/10. Something Cool DSD 512fs - 2ch.dsf","trackType":"dsf"} Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: CURRENT POSITION 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::syncState stateService play Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::syncState currentStatus stop Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 85ms Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand status took 56 milliseconds Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseTrackInfo Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::pushState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::servicePushState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":367,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"10. Something Cool DSD 512fs - 2ch.dsf","artist":"Various Artists","album":"TRUE AUDIOPHILE: Best Of Groove Note","uri":"USB/A0CC-7B51/10. Something Cool DSD 512fs - 2ch.dsf","trackType":"dsf"} Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: verbose: CURRENT POSITION 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::syncState stateService play Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::syncState currentStatus play Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: Received an update from plugin. extracting info from payload Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::pushState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::pushState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushState Oct 15 18:01:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:01:39 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 188ms Oct 15 18:01:40 ifi-idsd-phantom volumio[22728]: info: MetaClient: Sent Meta Oct 15 18:01:40 ifi-idsd-phantom node[490]: metadata.title changed Oct 15 18:01:40 ifi-idsd-phantom node[490]: metadata.album: http://127.0.0.1:3000/albumart?cacheid=538&web=Various%20Artists/TRUE%20AUDIOPHILE%3A%20Best%20Of%20Groove%20Note/extralarge&path=%2FUSB%2FA0CC-7B51&metadata=false Oct 15 18:01:40 ifi-idsd-phantom volumio[22728]: info: MetaClient: Get message: success Oct 15 18:01:40 ifi-idsd-phantom volumio[22728]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Various%20Artists/TRUE%20AUDIOPHILE%3A%20Best%20Of%20Groove%20Note/f8418d72-ed97-4b1e-a712-59b842568be5.jpg' Oct 15 18:01:40 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:40 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:40 ifi-idsd-phantom node[490]: Download data end Oct 15 18:01:41 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:41 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:42 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:42 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Preload queue cleared Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::ClearQueue Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::stop Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::stPlaybackTimer Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::updateTrackBlock Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrackBlock Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::pushState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::serviceStop Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 4 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::serviceStop Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::stop Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::clearPlayQueue Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::saveQueue Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushQueue Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::addQueueItems Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::addQueueItems Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Preload queue cleared Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/卢冠廷&莫文蔚-一生所爱.wav Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/卢冠廷&莫文蔚-一生所爱.wav Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/蔡琴 - 渡口.wav Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/蔡琴 - 渡口.wav Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/04. She's So Heavy DSD 512fs - 2ch.dsf Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/04. She's So Heavy DSD 512fs - 2ch.dsf Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/08. April In Paris DSD 512fs - 2ch.dsf Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/08. April In Paris DSD 512fs - 2ch.dsf Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushQueue Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::saveQueue Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::updateTrackBlock Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrackBlock Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ConvSwitch: Sent Play Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPlay Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::play index 3 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::addQueueItems Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::addQueueItems Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Preload queue cleared Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/10. Something Cool DSD 512fs - 2ch.dsf Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/10. Something Cool DSD 512fs - 2ch.dsf Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/(CD1)禅意原声 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/(CD1)禅意原声 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/张学友 -《歌神金曲珍藏》 DSD Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/张学友 -《歌神金曲珍藏》 DSD Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/张学友-真爱+真正精选 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/张学友-真爱+真正精选 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/洋澜一　2025《谁》 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/洋澜一　2025《谁》 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/碧那 - 一念归来 DSD Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/碧那 - 一念归来 DSD Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/罗文 射雕英雄传 Roman Tam - Denon Mastersonic - She Diao Ying Xiong Chuan Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/罗文 射雕英雄传 Roman Tam - Denon Mastersonic - She Diao Ying Xiong Chuan Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/运气来得若有似无 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/运气来得若有似无 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::stop Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::play index undefined Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::startPlaybackTimer Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: error: Could not retrieve plugin miscellanea metavolumio Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::clearAddPlayTracks USB/A0CC-7B51/08. April In Paris DSD 512fs - 2ch.dsf Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushQueue Oct 15 18:01:43 ifi-idsd-phantom ifi_metadata[23203]: Request 7 failed with result ResultCode::ILLEGAL_STATE Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::saveQueue Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::updateTrackBlock Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrackBlock Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces state update: player Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand stop took 150 milliseconds Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::getState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand status Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand stop took 62 milliseconds Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand clear Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ConvSwitch: Get message: success Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces system playlist update Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Ignoring MPD Status Update Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand status took 12 milliseconds Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand clear took 9 milliseconds Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand add "USB/A0CC-7B51/08. April In Paris DSD 512fs - 2ch.dsf" Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: error: updateQueue error: null Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces system playlist update Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Ignoring MPD Status Update Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 20ms Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand playlistinfo took 14 milliseconds Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand add "USB/A0CC-7B51/08. April In Paris DSD 512fs - 2ch.dsf" took 14 milliseconds Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseTrackInfo Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand play Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 44ms Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 16ms Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand play took 8 milliseconds Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces state update: player Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::getState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand status Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces state update: player Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::getState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand status Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand status took 23 milliseconds Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand status took 14 milliseconds Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseTrackInfo Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::pushState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::servicePushState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"08. April In Paris DSD 512fs - 2ch.dsf","artist":"Various Artists","album":"TRUE AUDIOPHILE: Best Of Groove Note","uri":"USB/A0CC-7B51/08. April In Paris DSD 512fs - 2ch.dsf","trackType":"dsf"} Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: CURRENT POSITION 3 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::syncState stateService play Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::syncState currentStatus stop Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 94ms Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand playlistinfo took 50 milliseconds Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseTrackInfo Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::pushState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::servicePushState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"22.58 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"08. April In Paris DSD 512fs - 2ch.dsf","artist":"Various Artists","album":"TRUE AUDIOPHILE: Best Of Groove Note","uri":"USB/A0CC-7B51/08. April In Paris DSD 512fs - 2ch.dsf","trackType":"dsf"} Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: verbose: CURRENT POSITION 3 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::syncState stateService play Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::syncState currentStatus play Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: Received an update from plugin. extracting info from payload Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::pushState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::pushState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushState Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:01:43 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 181ms Oct 15 18:01:44 ifi-idsd-phantom volumio[22728]: info: MetaClient: Sent Meta Oct 15 18:01:44 ifi-idsd-phantom node[490]: metadata.title changed Oct 15 18:01:44 ifi-idsd-phantom node[490]: metadata.album: http://127.0.0.1:3000/albumart?cacheid=538&web=Various%20Artists/TRUE%20AUDIOPHILE%3A%20Best%20Of%20Groove%20Note/extralarge&path=%2FUSB%2FA0CC-7B51&metadata=false Oct 15 18:01:44 ifi-idsd-phantom volumio[22728]: info: MetaClient: Get message: success Oct 15 18:01:44 ifi-idsd-phantom volumio[22728]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Various%20Artists/TRUE%20AUDIOPHILE%3A%20Best%20Of%20Groove%20Note/f8418d72-ed97-4b1e-a712-59b842568be5.jpg' Oct 15 18:01:44 ifi-idsd-phantom node[490]: Download data end Oct 15 18:01:44 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:44 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:45 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:45 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:46 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:46 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:47 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:47 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:48 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:48 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:49 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:49 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:50 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:50 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:51 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:51 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:52 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:52 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:53 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:53 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:54 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:54 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:55 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:55 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:55 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 18:01:55 ifi-idsd-phantom volumio[22728]: info: CURURI: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preload queue cleared Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/1.Goldeneye (From _Goldeneye_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/2.Skyfall (From _Skyfall_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/3.Live and Let Die (From _Live and Let Die_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/4.Now We Are Free (From _Gladiator_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/5.Main Title (From _Patch Adams_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/6.La valse d’Amélie (From _Amélie_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/7.Le moulin (From _Amélie_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/8.Comptine d’un autre été_ L’après midi (From _Amélie_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/9.La dispute (From _Amélie_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/10.Comptine d’été No. 2 (From _Amélie_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/11.Comptine d’été No. 3 (From _Amélie_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/12.He's a Pirate (From _Pirates of the Caribbean_ The Curse of the Black Pearl_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/13.Tennessee (From _Pearl Harbor_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/14.Circle of Life (From _The Lion King_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/15.Viva la Vida.flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/16.Theme (From _Mission_ Impossible_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/17.The Heart Asks Pleasure First (From _The Piano_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/18.Theme (From _Schindler's List_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/19.Harry Potter Medley (After J. Williams).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/20.Griet’s Theme (From _Girl with a Pearl Earring_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/21.Keyboard Sonata in D Minor, Kk. 141.flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/22.Keyboard Sonata in E Major, Kk. 380.flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/23.Keyboard Sonata in C major, Kk. 159.flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/24.Chants d'Espagne, Op. 232 (Excerpts)_ No. 1, Prélude.flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/25.Chants d'Espagne, Op. 232 (Excerpts)_ No. 2, Orientale.flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/26.Chants d'Espagne, Op. 232 (Excerpts)_ No. 3, Sous le Palmier.flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Preloading song: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/27.Una mattina (From _The Intouchables_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/1.Goldeneye (From _Goldeneye_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F1.Goldeneye%20(From%20_Goldeneye_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/1.Goldeneye (From _Goldeneye_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/2.Skyfall (From _Skyfall_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F2.Skyfall%20(From%20_Skyfall_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/2.Skyfall (From _Skyfall_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/3.Live and Let Die (From _Live and Let Die_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F3.Live%20and%20Let%20Die%20(From%20_Live%20and%20Let%20Die_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/3.Live and Let Die (From _Live and Let Die_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/4.Now We Are Free (From _Gladiator_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F4.Now%20We%20Are%20Free%20(From%20_Gladiator_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/4.Now We Are Free (From _Gladiator_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/5.Main Title (From _Patch Adams_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F5.Main%20Title%20(From%20_Patch%20Adams_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/5.Main Title (From _Patch Adams_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/6.La valse d’Amélie (From _Amélie_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F6.La%20valse%20d%E2%80%99Am%C3%A9lie%20(From%20_Am%C3%A9lie_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/6.La valse d’Amélie (From _Amélie_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/7.Le moulin (From _Amélie_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F7.Le%20moulin%20(From%20_Am%C3%A9lie_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/7.Le moulin (From _Amélie_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/8.Comptine d’un autre été_ L’après midi (From _Amélie_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F8.Comptine%20d%E2%80%99un%20autre%20%C3%A9t%C3%A9_%20L%E2%80%99apr%C3%A8s%20midi%20(From%20_Am%C3%A9lie_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/8.Comptine d’un autre été_ L’après midi (From _Amélie_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/9.La dispute (From _Amélie_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F9.La%20dispute%20(From%20_Am%C3%A9lie_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/9.La dispute (From _Amélie_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/10.Comptine d’été No. 2 (From _Amélie_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F10.Comptine%20d%E2%80%99%C3%A9t%C3%A9%20No.%202%20(From%20_Am%C3%A9lie_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/10.Comptine d’été No. 2 (From _Amélie_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/11.Comptine d’été No. 3 (From _Amélie_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F11.Comptine%20d%E2%80%99%C3%A9t%C3%A9%20No.%203%20(From%20_Am%C3%A9lie_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/11.Comptine d’été No. 3 (From _Amélie_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/12.He's a Pirate (From _Pirates of the Caribbean_ The Curse of the Black Pearl_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F12.He's%20a%20Pirate%20(From%20_Pirates%20of%20the%20Caribbean_%20The%20Curse%20of%20the%20Black%20Pearl_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/12.He's a Pirate (From _Pirates of the Caribbean_ The Curse of the Black Pearl_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/13.Tennessee (From _Pearl Harbor_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F13.Tennessee%20(From%20_Pearl%20Harbor_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/13.Tennessee (From _Pearl Harbor_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/14.Circle of Life (From _The Lion King_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F14.Circle%20of%20Life%20(From%20_The%20Lion%20King_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/14.Circle of Life (From _The Lion King_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/15.Viva la Vida.flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F15.Viva%20la%20Vida.flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/15.Viva la Vida.flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/16.Theme (From _Mission_ Impossible_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F16.Theme%20(From%20_Mission_%20Impossible_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/16.Theme (From _Mission_ Impossible_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/17.The Heart Asks Pleasure First (From _The Piano_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F17.The%20Heart%20Asks%20Pleasure%20First%20(From%20_The%20Piano_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/17.The Heart Asks Pleasure First (From _The Piano_).flac Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/18.Theme (From _Schindler's List_).flac in service mpd Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F18.Theme%20(From%20_Schindler's%20List_).flac&metadata=false Oct 15 18:01:56 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/18.Theme (From _Schindler's List_).flac Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/19.Harry Potter Medley (After J. Williams).flac in service mpd Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F19.Harry%20Potter%20Medley%20(After%20J.%20Williams).flac&metadata=false Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/19.Harry Potter Medley (After J. Williams).flac Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/20.Griet’s Theme (From _Girl with a Pearl Earring_).flac in service mpd Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F20.Griet%E2%80%99s%20Theme%20(From%20_Girl%20with%20a%20Pearl%20Earring_).flac&metadata=false Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/20.Griet’s Theme (From _Girl with a Pearl Earring_).flac Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/21.Keyboard Sonata in D Minor, Kk. 141.flac in service mpd Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F21.Keyboard%20Sonata%20in%20D%20Minor%2C%20Kk.%20141.flac&metadata=false Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/21.Keyboard Sonata in D Minor, Kk. 141.flac Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/22.Keyboard Sonata in E Major, Kk. 380.flac in service mpd Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F22.Keyboard%20Sonata%20in%20E%20Major%2C%20Kk.%20380.flac&metadata=false Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/22.Keyboard Sonata in E Major, Kk. 380.flac Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/23.Keyboard Sonata in C major, Kk. 159.flac in service mpd Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F23.Keyboard%20Sonata%20in%20C%20major%2C%20Kk.%20159.flac&metadata=false Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/23.Keyboard Sonata in C major, Kk. 159.flac Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/24.Chants d'Espagne, Op. 232 (Excerpts)_ No. 1, Prélude.flac in service mpd Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F24.Chants%20d'Espagne%2C%20Op.%20232%20(Excerpts)_%20No.%201%2C%20Pr%C3%A9lude.flac&metadata=false Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/24.Chants d'Espagne, Op. 232 (Excerpts)_ No. 1, Prélude.flac Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/25.Chants d'Espagne, Op. 232 (Excerpts)_ No. 2, Orientale.flac in service mpd Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F25.Chants%20d'Espagne%2C%20Op.%20232%20(Excerpts)_%20No.%202%2C%20Orientale.flac&metadata=false Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/25.Chants d'Espagne, Op. 232 (Excerpts)_ No. 2, Orientale.flac Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/26.Chants d'Espagne, Op. 232 (Excerpts)_ No. 3, Sous le Palmier.flac in service mpd Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F26.Chants%20d'Espagne%2C%20Op.%20232%20(Excerpts)_%20No.%203%2C%20Sous%20le%20Palmier.flac&metadata=false Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/26.Chants d'Espagne, Op. 232 (Excerpts)_ No. 3, Sous le Palmier.flac Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/27.Una mattina (From _The Intouchables_).flac in service mpd Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: ALBUMART /albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2Fmnt%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred%2F27.Una%20mattina%20(From%20_The%20Intouchables_).flac&metadata=false Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: URI /mnt/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/27.Una mattina (From _The Intouchables_).flac Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:57 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:58 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:58 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:01:59 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:01:59 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:00 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:00 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:01 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:01 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:01 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:01.976 D zc pump:mDNS :963 mdns_pump mDNS: Read 97 bytes from socket Oct 15 18:02:01 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:01.976 D zc pump:mDNS :343 mdns_parse_questions read packet with question 1 flags 0x0 Oct 15 18:02:01 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:01.976 D zc pump:mDNS :377 mdns_parse_questions read question for _iFi._tcp.local. (0xc) Oct 15 18:02:01 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:01.976 D zc pump:mDNS :206 mdns_service_match match _iFi._tcp.local. (16) with 46:85:0d:1d:b0:45 (17) _spotify-connect._tcp.local. (28) Oct 15 18:02:01 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:01.976 D zc pump:mDNS :215 mdns_service_match match _iFi._tcp.local. (16) with _spotify-connect._tcp.local. (28) Oct 15 18:02:01 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:01.976 D zc pump:mDNS :227 mdns_service_match match _iFi._tcp.local. (16) with _services._dns-sd._udp.local. (29) Oct 15 18:02:01 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:01.976 D zc pump:mDNS :429 mdns_parse_questions ignored, not matching service filter Oct 15 18:02:02 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:02 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:03 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:03 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:04 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:04 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:05 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:05 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:06 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:06 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:07 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:07 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:08 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:08 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:09 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:09 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:10 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:10 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:11 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:11 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:12 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:12 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:13 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:13 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:14 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:14 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Preload queue cleared Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::ClearQueue Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::stop Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::stPlaybackTimer Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::updateTrackBlock Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrackBlock Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::pushState Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushState Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::serviceStop Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 3 Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::serviceStop Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::stop Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::clearPlayQueue Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::saveQueue Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushQueue Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::addQueueItems Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::addQueueItems Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Preload queue cleared Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/1.Goldeneye (From _Goldeneye_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/1.Goldeneye (From _Goldeneye_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/2.Skyfall (From _Skyfall_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/2.Skyfall (From _Skyfall_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/3.Live and Let Die (From _Live and Let Die_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/3.Live and Let Die (From _Live and Let Die_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/4.Now We Are Free (From _Gladiator_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/4.Now We Are Free (From _Gladiator_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/5.Main Title (From _Patch Adams_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/5.Main Title (From _Patch Adams_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/6.La valse d’Amélie (From _Amélie_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/6.La valse d’Amélie (From _Amélie_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/7.Le moulin (From _Amélie_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/7.Le moulin (From _Amélie_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/8.Comptine d’un autre été_ L’après midi (From _Amélie_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/8.Comptine d’un autre été_ L’après midi (From _Amélie_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/9.La dispute (From _Amélie_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/9.La dispute (From _Amélie_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/10.Comptine d’été No. 2 (From _Amélie_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/10.Comptine d’été No. 2 (From _Amélie_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/11.Comptine d’été No. 3 (From _Amélie_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/11.Comptine d’été No. 3 (From _Amélie_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/12.He's a Pirate (From _Pirates of the Caribbean_ The Curse of the Black Pearl_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/12.He's a Pirate (From _Pirates of the Caribbean_ The Curse of the Black Pearl_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/13.Tennessee (From _Pearl Harbor_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/13.Tennessee (From _Pearl Harbor_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushQueue Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::saveQueue Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::updateTrackBlock Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrackBlock Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: ConvSwitch: Sent Play Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPlay Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::play index 12 Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::addQueueItems Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::addQueueItems Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Preload queue cleared Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/14.Circle of Life (From _The Lion King_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/14.Circle of Life (From _The Lion King_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/15.Viva la Vida.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/15.Viva la Vida.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/16.Theme (From _Mission_ Impossible_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/16.Theme (From _Mission_ Impossible_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/17.The Heart Asks Pleasure First (From _The Piano_).flac Oct 15 18:02:15 ifi-idsd-phantom ifi_metadata[23203]: Request 8 failed with result ResultCode::ILLEGAL_STATE Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/17.The Heart Asks Pleasure First (From _The Piano_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/18.Theme (From _Schindler's List_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/18.Theme (From _Schindler's List_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/19.Harry Potter Medley (After J. Williams).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/19.Harry Potter Medley (After J. Williams).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/20.Griet’s Theme (From _Girl with a Pearl Earring_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/20.Griet’s Theme (From _Girl with a Pearl Earring_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/21.Keyboard Sonata in D Minor, Kk. 141.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/21.Keyboard Sonata in D Minor, Kk. 141.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/22.Keyboard Sonata in E Major, Kk. 380.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/22.Keyboard Sonata in E Major, Kk. 380.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/23.Keyboard Sonata in C major, Kk. 159.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/23.Keyboard Sonata in C major, Kk. 159.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/24.Chants d'Espagne, Op. 232 (Excerpts)_ No. 1, Prélude.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/24.Chants d'Espagne, Op. 232 (Excerpts)_ No. 1, Prélude.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/25.Chants d'Espagne, Op. 232 (Excerpts)_ No. 2, Orientale.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/25.Chants d'Espagne, Op. 232 (Excerpts)_ No. 2, Orientale.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/26.Chants d'Espagne, Op. 232 (Excerpts)_ No. 3, Sous le Palmier.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/26.Chants d'Espagne, Op. 232 (Excerpts)_ No. 3, Sous le Palmier.flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/27.Una mattina (From _The Intouchables_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Using cached record of: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/27.Una mattina (From _The Intouchables_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::stop Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::play index undefined Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::startPlaybackTimer Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: error: Could not retrieve plugin miscellanea metavolumio Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::clearAddPlayTracks USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/13.Tennessee (From _Pearl Harbor_).flac Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushQueue Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::saveQueue Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::updateTrackBlock Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrackBlock Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces state update: player Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand stop took 181 milliseconds Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::getState Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand status Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand stop took 59 milliseconds Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand clear Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: ConvSwitch: Get message: success Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces system playlist update Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Ignoring MPD Status Update Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand status took 10 milliseconds Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand clear took 9 milliseconds Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseState Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand add "USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/13.Tennessee (From _Pearl Harbor_).flac" Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: error: updateQueue error: null Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces system playlist update Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Ignoring MPD Status Update Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 16ms Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand add "USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/13.Tennessee (From _Pearl Harbor_).flac" took 10 milliseconds Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseTrackInfo Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand play Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 36ms Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 16ms Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand play took 10 milliseconds Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces state update: player Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::getState Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand status Oct 15 18:02:15 ifi-idsd-phantom kernel: mute_store Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: MetaClient: Get message: request:setvolume:18,1 Oct 15 18:02:15 ifi-idsd-phantom volumio[22728]: info: VolumeController::SetAlsaVolumemute Oct 15 18:02:15 ifi-idsd-phantom kernel: GAIN_18dB Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::pushState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: ---------------------------- MPD announces state update: player Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand status took 109 milliseconds Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::getState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand status Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand status took 14 milliseconds Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseTrackInfo Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::pushState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::servicePushState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":225,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tennessee (From \"Pearl Harbor\")","artist":"Anna Scheps","album":"Classic Meets Movie: Shaken Not Stirred","uri":"USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/13.Tennessee (From _Pearl Harbor_).flac","trackType":"flac"} Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: verbose: CURRENT POSITION 12 Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::syncState stateService play Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::syncState currentStatus stop Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 173ms Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: sendMpdCommand playlistinfo took 37 milliseconds Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: verbose: ControllerMpd::parseTrackInfo Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: ControllerMpd::pushState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::servicePushState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":225,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2146 Kbps","isStreaming":false,"title":"Tennessee (From \"Pearl Harbor\")","artist":"Anna Scheps","album":"Classic Meets Movie: Shaken Not Stirred","uri":"USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/13.Tennessee (From _Pearl Harbor_).flac","trackType":"flac"} Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: verbose: CURRENT POSITION 12 Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::syncState stateService play Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::syncState currentStatus play Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: Received an update from plugin. extracting info from payload Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::pushState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::pushState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: ------------------------------ 117ms Oct 15 18:02:16 ifi-idsd-phantom kernel: unmute_store Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: MetaClient: Get message: request:setvolume:18,0 Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: VolumeController::SetAlsaVolume18 Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreStateMachine::pushState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioPushState Oct 15 18:02:16 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:17 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:17 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:17 ifi-idsd-phantom volumio[22728]: info: MetaClient: Sent Meta Oct 15 18:02:17 ifi-idsd-phantom node[490]: metadata.title changed Oct 15 18:02:17 ifi-idsd-phantom node[490]: metadata.album: http://127.0.0.1:3000/albumart?cacheid=538&web=Anna%20Scheps/Classic%20Meets%20Movie%3A%20Shaken%20Not%20Stirred/extralarge&path=%2FUSB%2FA0CC-7B51%2F%E5%BD%93%E5%8F%A4%E5%85%B8%E4%B9%90%E9%81%87%E8%A7%81%E7%94%B5%E5%BD%B1%20Shaken%20Not%20Stirred&metadata=false Oct 15 18:02:17 ifi-idsd-phantom volumio[22728]: info: MetaClient: Get message: success Oct 15 18:02:17 ifi-idsd-phantom node[490]: Download data end Oct 15 18:02:18 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:18 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:19 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:19 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:20 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:20 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:21 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:21 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:22 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:22 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:22 ifi-idsd-phantom volumiologrotate[460]: ls: cannot access '/var/log/samba/log.wb-IDSD': No such file or directory Oct 15 18:02:22 ifi-idsd-phantom volumiologrotate[460]: ls: cannot access 'PHANTOM': No such file or directory Oct 15 18:02:23 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:23 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:24 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:24 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:25 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:25 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:26 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:26 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:27 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:27 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:28 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:28 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:29 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:29 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:30 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:30 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:31 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:31 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:32 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:32 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:33 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:33 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:34 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:34 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:35 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:35 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:36 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:36 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:37 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:37 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:38 ifi-idsd-phantom volumio[22728]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:38 ifi-idsd-phantom volumio[22728]: info: CorePlayQueue::getTrack 12 Oct 15 18:02:38 ifi-idsd-phantom volumio[22728]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 18:02:38 ifi-idsd-phantom volumio[22728]: Error: connect ETIMEDOUT 208.43.237.140:443 Oct 15 18:02:38 ifi-idsd-phantom volumio[22728]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 15 18:02:38 ifi-idsd-phantom volumio[22728]: errno: -110, Oct 15 18:02:38 ifi-idsd-phantom volumio[22728]: code: 'ETIMEDOUT', Oct 15 18:02:38 ifi-idsd-phantom volumio[22728]: syscall: 'connect', Oct 15 18:02:38 ifi-idsd-phantom volumio[22728]: address: '208.43.237.140', Oct 15 18:02:38 ifi-idsd-phantom volumio[22728]: port: 443 Oct 15 18:02:38 ifi-idsd-phantom volumio[22728]: } Oct 15 18:02:38 ifi-idsd-phantom volumio[22728]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 18:02:39 ifi-idsd-phantom sudo[28747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-15 18:01 Oct 15 18:02:39 ifi-idsd-phantom sudo[28747]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:39 ifi-idsd-phantom sudo[28747]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:41 ifi-idsd-phantom systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 15 18:02:41 ifi-idsd-phantom node[490]: Closing connection with the client volumio Oct 15 18:02:41 ifi-idsd-phantom node[459]: ConvSwitch: Drop client volumio Oct 15 18:02:41 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:41.939 D zc pump:mDNS :963 mdns_pump mDNS: Read 264 bytes from socket Oct 15 18:02:41 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:41.939 D zc pump:mDNS :339 mdns_parse_questions ignoring packet with flags 0x8400 Oct 15 18:02:41 ifi-idsd-phantom mount.exfat[22828]: non-zero reference counter (1) for '13.Tennessee (From _Pearl Harbor_).flac' Oct 15 18:02:41 ifi-idsd-phantom systemd[1]: media-A0CC\x2d7B51.mount: Succeeded. Oct 15 18:02:41 ifi-idsd-phantom systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 15 18:02:41 ifi-idsd-phantom systemd[1]: Started dynamicswap service. Oct 15 18:02:42 ifi-idsd-phantom systemd[1]: dynamicswap.service: Succeeded. Oct 15 18:02:42 ifi-idsd-phantom systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 15 18:02:42 ifi-idsd-phantom systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Oct 15 18:02:42 ifi-idsd-phantom systemd[1]: Started dynamicswap service. Oct 15 18:02:42 ifi-idsd-phantom systemd[1]: Stopped Volumio Backend Module. Oct 15 18:02:42 ifi-idsd-phantom systemd[1]: Started Volumio Backend Module. Oct 15 18:02:42 ifi-idsd-phantom systemd[1]: dynamicswap.service: Succeeded. Oct 15 18:02:45 ifi-idsd-phantom volumio[28839]: info: ------------------------------------------- Oct 15 18:02:45 ifi-idsd-phantom volumio[28839]: info: ----- Volumio3 ---- Oct 15 18:02:45 ifi-idsd-phantom volumio[28839]: info: ------------------------------------------- Oct 15 18:02:45 ifi-idsd-phantom volumio[28839]: info: ----- System startup ---- Oct 15 18:02:45 ifi-idsd-phantom volumio[28839]: info: ------------------------------------------- Oct 15 18:02:45 ifi-idsd-phantom volumio[28839]: info: ConvSwitch: Client Start Oct 15 18:02:45 ifi-idsd-phantom volumio[28839]: info: MetaClient: Client Start Oct 15 18:02:45 ifi-idsd-phantom node[490]: A new connection has been established. Oct 15 18:02:45 ifi-idsd-phantom volumio[28839]: Removing existing socket file at /tmp/meta.sock Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Plugin folders cleanup Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Scanning into folder /volumio/app/plugins/ Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Scanning category audio_interface Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Scanning category miscellanea Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Scanning category music_service Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Scanning category plugins.json Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Scanning category system_controller Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Scanning category user_interface Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Scanning into folder /data/plugins/ Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Scanning category music_service Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Plugin folders cleanup completed Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: ------------------------------------------- Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: ----- Core plugins startup ---- Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: ------------------------------------------- Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Loading plugins from folder /volumio/app/plugins/ Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Adding plugin networkaudiod to MyMusic Plugins Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Adding plugin qobuz_connect to MyMusic Plugins Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Adding plugin spotify_connect to MyMusic Plugins Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Adding plugin tidal_connect to MyMusic Plugins Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Adding plugin upnp to MyMusic Plugins Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Adding plugin airplay1_switch to MyMusic Plugins Oct 15 18:02:46 ifi-idsd-phantom volumio[28839]: info: Adding plugin airplay2_switch to MyMusic Plugins Oct 15 18:02:47 ifi-idsd-phantom volumio[28839]: info: Adding plugin roon_ready to MyMusic Plugins Oct 15 18:02:47 ifi-idsd-phantom volumio[28839]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 15 18:02:47 ifi-idsd-phantom volumio[28839]: info: Loading plugins from folder /data/plugins/ Oct 15 18:02:47 ifi-idsd-phantom volumio[28839]: info: Loading plugin "system"... Oct 15 18:02:47 ifi-idsd-phantom volumio[28839]: info: Loading plugin "appearance"... Oct 15 18:02:48 ifi-idsd-phantom volumio[28839]: info: Loading plugin "network"... Oct 15 18:02:48 ifi-idsd-phantom volumio[28839]: info: Refreshing Cached IP Addresses Oct 15 18:02:49 ifi-idsd-phantom sudo[29091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 18:02:49 ifi-idsd-phantom sudo[29091]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:49 ifi-idsd-phantom sudo[29091]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:49 ifi-idsd-phantom sudo[29093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 18:02:49 ifi-idsd-phantom sudo[29093]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:49 ifi-idsd-phantom sudo[29093]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Loading plugin "services"... Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Loading plugin "alsa_controller"... Oct 15 18:02:49 ifi-idsd-phantom sudo[29111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 15 18:02:49 ifi-idsd-phantom sudo[29111]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Loading plugin "wizard"... Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Loading plugin "networkfs"... Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Starting Udev Watcher for removable devices Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: error: Cannot associate FS Label, not mounting Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: error: Cannot associate FS Label, not mounting Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Ignoring mount for partition: BOOT Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Ignoring mount for partition: archivefs Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Ignoring mount for partition: rootfs Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Mounting Device A0CC-7B51 Oct 15 18:02:49 ifi-idsd-phantom sudo[29149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/A0CC-7B51 -o noatime Oct 15 18:02:49 ifi-idsd-phantom sudo[29149]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:49 ifi-idsd-phantom sudo[29149]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Loading plugin "volumio_command_line_client"... Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Loading plugin "networkaudiod"... Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: [1792087369646] Starting NAA Service Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Loading plugin "tidal_connect"... Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: [1792087369675] Starting Tidal Connect Service Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Loading plugin "upnp"... Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: [1792087369688] Starting Upmpd Daemon Oct 15 18:02:49 ifi-idsd-phantom sudo[29155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart networkaudiod.service Oct 15 18:02:49 ifi-idsd-phantom sudo[29155]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Starting Upmpd Daemon Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: error: ATTENTION!!!: Plugin upnp does not return adequate promise from onVolumioStart: please update! Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Loading plugin "my_music"... Oct 15 18:02:49 ifi-idsd-phantom volumio[28839]: info: Loading plugin "mpd"... Oct 15 18:02:49 ifi-idsd-phantom systemd[1]: Stopping Network Audio Adapter daemon... Oct 15 18:02:49 ifi-idsd-phantom systemd[1]: networkaudiod.service: Succeeded. Oct 15 18:02:49 ifi-idsd-phantom systemd[1]: Stopped Network Audio Adapter daemon. Oct 15 18:02:49 ifi-idsd-phantom systemd[1]: Started Network Audio Adapter daemon. Oct 15 18:02:49 ifi-idsd-phantom sudo[29155]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:49 ifi-idsd-phantom networkaudiod[29157]: [/usr/sbin/networkaudiod] (29157): networkaudiod Copyright (C) 2011-2020 Jussi Laako / Signalyst. All rights reserved. Oct 15 18:02:49 ifi-idsd-phantom networkaudiod[29157]: [/usr/sbin/networkaudiod] (29157): create alsa engine Oct 15 18:02:49 ifi-idsd-phantom networkaudiod[29157]: [/usr/sbin/networkaudiod] (29157): listen discovery on :: Oct 15 18:02:49 ifi-idsd-phantom networkaudiod[29157]: [/usr/sbin/networkaudiod] (29157): clSocket::SetOption(): setsockopt(..., 41,20, ...): No such device Oct 15 18:02:49 ifi-idsd-phantom networkaudiod[29157]: [/usr/sbin/networkaudiod] (29157): Socket failure, falling back to IPv4-only! Oct 15 18:02:50 ifi-idsd-phantom volumio[28839]: info: Loading plugin "upnp_browser"... Oct 15 18:02:50 ifi-idsd-phantom networkaudiod[29157]: [/usr/sbin/networkaudiod] (29157): listen discovery on 0.0.0.0 Oct 15 18:02:50 ifi-idsd-phantom volumio[28839]: info: Loading plugin "qobuz_connect"... Oct 15 18:02:50 ifi-idsd-phantom volumio[28839]: info: [1792087370917] Starting Qobuz Connect Service Oct 15 18:02:50 ifi-idsd-phantom volumio[28839]: info: Loading plugin "alarm-clock"... Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Loading plugin "last_100"... Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Loading plugin "roon_ready"... Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Starting RoonReady Sync Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Loading plugin "webradio"... Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Loading plugin "i2s_dacs"... Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: I2S DAC not set, start Auto-detection Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Loading plugin "volumiodiscovery"... Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: *** WARNING *** For more information see Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: *** WARNING *** For more information see Oct 15 18:02:51 ifi-idsd-phantom node[28839]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 18:02:51 ifi-idsd-phantom node[28839]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 18:02:51 ifi-idsd-phantom node[28839]: *** WARNING *** For more information see Oct 15 18:02:51 ifi-idsd-phantom node[28839]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 18:02:51 ifi-idsd-phantom node[28839]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 18:02:51 ifi-idsd-phantom node[28839]: *** WARNING *** For more information see Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Loading plugin "spotify_connect"... Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: [1792087371522] Starting Spotify Connect Service Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Plugin airplay1_switch is not enabled Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Loading plugin "airplay2_switch"... Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Loading plugin "airplay_emulation"... Oct 15 18:02:51 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:51.549 D zc pump:mDNS :963 mdns_pump mDNS: Read 203 bytes from socket Oct 15 18:02:51 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:51.550 D zc pump:mDNS :343 mdns_parse_questions read packet with question 1 flags 0x0 Oct 15 18:02:51 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:51.550 D zc pump:mDNS :377 mdns_parse_questions read question for ifi-phmidsd-iDSD PHANTOM [FC:B5:85:E8:CD:D9]-D10C._iFi._tcp.local. (0xff) Oct 15 18:02:51 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:51.550 D zc pump:mDNS :383 mdns_parse_questions ignored, unrecognized question type ff Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Starting Shairport Sync Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Loading plugin "outputs"... Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Loading plugin "albumart"... Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Plugin example_plugin is not enabled Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Loading plugin "inputs"... Oct 15 18:02:51 ifi-idsd-phantom volumio[28839]: info: Loading plugin "updater_comm"... Oct 15 18:02:51 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:51.800 D zc pump:mDNS :963 mdns_pump mDNS: Read 203 bytes from socket Oct 15 18:02:51 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:51.801 D zc pump:mDNS :343 mdns_parse_questions read packet with question 1 flags 0x0 Oct 15 18:02:51 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:51.801 D zc pump:mDNS :377 mdns_parse_questions read question for ifi-phmidsd-iDSD PHANTOM [FC:B5:85:E8:CD:D9]-D10C._iFi._tcp.local. (0xff) Oct 15 18:02:51 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:51.801 D zc pump:mDNS :383 mdns_parse_questions ignored, unrecognized question type ff Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: Plugin mpdemulation is not enabled Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: Loading plugin "rest_api"... Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: Loading plugin "websocket"... Oct 15 18:02:52 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:52.052 D zc pump:mDNS :963 mdns_pump mDNS: Read 203 bytes from socket Oct 15 18:02:52 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:52.052 D zc pump:mDNS :343 mdns_parse_questions read packet with question 1 flags 0x0 Oct 15 18:02:52 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:52.052 D zc pump:mDNS :377 mdns_parse_questions read question for ifi-phmidsd-iDSD PHANTOM [FC:B5:85:E8:CD:D9]-D10C._iFi._tcp.local. (0xff) Oct 15 18:02:52 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:52.052 D zc pump:mDNS :383 mdns_parse_questions ignored, unrecognized question type ff Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: Starting Socket.io Server version 2.3.0 Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: Plugin ifi-cdplayer is not enabled Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: Loading i18n strings for locale en Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: Updating browse sources language Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 18:02:52 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:52.252 D zc pump:mDNS :963 mdns_pump mDNS: Read 264 bytes from socket Oct 15 18:02:52 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:52.253 D zc pump:mDNS :339 mdns_parse_questions ignoring packet with flags 0x8400 Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: Forking 3 albumart workers Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::initPlayerControls Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: Express server listening on port 3000 Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: [Metrics] WebUI: 8s 618.46ms Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: Meta server listening Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::resetVolumioState Oct 15 18:02:52 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::getcurrentVolume Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::pushState Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioPushState Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: Server listening on port 6599 Oct 15 18:02:53 ifi-idsd-phantom sudo[29299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Oct 15 18:02:53 ifi-idsd-phantom sudo[29299]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 15 18:02:53 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:53.258 D zc pump:mDNS :963 mdns_pump mDNS: Read 264 bytes from socket Oct 15 18:02:53 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:53.258 D zc pump:mDNS :339 mdns_parse_questions ignoring packet with flags 0x8400 Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: Completed loading Core Plugins Oct 15 18:02:53 ifi-idsd-phantom sudo[29301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Oct 15 18:02:53 ifi-idsd-phantom sudo[29301]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: Preparing to generate the ALSA configuration file Oct 15 18:02:53 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Oct 15 18:02:53 ifi-idsd-phantom node[459]: ConvSwitch: Drop client tidal Oct 15 18:02:53 ifi-idsd-phantom systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Oct 15 18:02:53 ifi-idsd-phantom node[490]: Closing connection with the client tidal-connect Oct 15 18:02:53 ifi-idsd-phantom systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Oct 15 18:02:53 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Oct 15 18:02:53 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Tidal Connect Service... Oct 15 18:02:53 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:53.371 D zc pump:mDNS :963 mdns_pump mDNS: Read 260 bytes from socket Oct 15 18:02:53 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:53.371 D zc pump:mDNS :339 mdns_parse_questions ignoring packet with flags 0x8400 Oct 15 18:02:53 ifi-idsd-phantom systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Oct 15 18:02:53 ifi-idsd-phantom systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Oct 15 18:02:53 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Tidal Connect Service. Oct 15 18:02:53 ifi-idsd-phantom sudo[29301]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: ConvSwitch: Connected to server Oct 15 18:02:53 ifi-idsd-phantom node[459]: ConvSwitch: Add client volumio Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: MetaClient: Connected to server Oct 15 18:02:53 ifi-idsd-phantom systemd[1]: Started iFi Streamer Tidal Connect Service. Oct 15 18:02:53 ifi-idsd-phantom sudo[29299]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:53 ifi-idsd-phantom systemd[1]: Started iFi Streamer Tidal Metadata Service. Oct 15 18:02:53 ifi-idsd-phantom node[490]: A new connection has been established. Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: Volumio Network Manager: Network status updated: 2 Oct 15 18:02:53 ifi-idsd-phantom node[459]: ConvSwitch: Add client tidal Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: NAA Service Started Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: ConvSwitch: Get message: success Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: MetaClient: Get message: success Oct 15 18:02:53 ifi-idsd-phantom sudo[29111]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: verbose: New Socket.io Connection to 192.168.31.178 from 192.168.31.64 UA: okhttp/3.12.11 Engine version: 3 Transport: websocket Total Clients: 1 Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: Tidal Connect Service Started Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: Qobuz Connect Service Started Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: Reloading queue from file Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: Asound.conf file unchanged, so no further update is needed Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: Tidal connect: Output device has changed Oct 15 18:02:53 ifi-idsd-phantom volumio[28839]: info: Output device has changed, restarting MPD Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: Qobuz connect: Output device has changed Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: Roon Ready: Output device has changed Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: Spotify: Output device has changed Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: ___________ START PLUGINS ___________ Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: ControllerMpd::onStart: Initializing MPD Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: Creating MPD Configuration file Oct 15 18:02:54 ifi-idsd-phantom sudo[29320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 18:02:54 ifi-idsd-phantom sudo[29320]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:54 ifi-idsd-phantom sudo[29320]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: [1792087374186] CoreMusicLibrary::Adding element Media Servers Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 18:02:54 ifi-idsd-phantom sudo[29323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 18:02:54 ifi-idsd-phantom sudo[29323]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:54 ifi-idsd-phantom sudo[29325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Oct 15 18:02:54 ifi-idsd-phantom sudo[29323]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:54 ifi-idsd-phantom sudo[29325]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: Starting albumart workers Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: Starting albumart workers Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: [1792087374293] CoreMusicLibrary::Adding element Last_100 Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: Starting RoonReady Sync Oct 15 18:02:54 ifi-idsd-phantom systemd[1]: mpd.socket: Succeeded. Oct 15 18:02:54 ifi-idsd-phantom systemd[1]: Closed mpd.socket. Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: [1792087374334] CoreMusicLibrary::Adding element Webradio Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 18:02:54 ifi-idsd-phantom systemd[1]: Stopping Music Player Daemon... Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: Starting albumart workers Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: Initializing BBC Radios Oct 15 18:02:54 ifi-idsd-phantom sudo[29329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Oct 15 18:02:54 ifi-idsd-phantom sudo[29329]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:54 ifi-idsd-phantom node[459]: ConvSwitch: Drop client roon-ready Oct 15 18:02:54 ifi-idsd-phantom node[490]: Closing connection with the client roon-ready Oct 15 18:02:54 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Roon Ready Service... Oct 15 18:02:54 ifi-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Oct 15 18:02:54 ifi-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Oct 15 18:02:54 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Oct 15 18:02:54 ifi-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Oct 15 18:02:54 ifi-idsd-phantom sudo[29329]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:54 ifi-idsd-phantom play[29337]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Oct 15 18:02:54 ifi-idsd-phantom systemd[1]: mpd.service: Succeeded. Oct 15 18:02:54 ifi-idsd-phantom systemd[1]: Stopped Music Player Daemon. Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 18:02:54 ifi-idsd-phantom sudo[29325]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:54 ifi-idsd-phantom sudo[29349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -snf /usr/local/bin/airplay2 /usr/local/bin/shairport-sync Oct 15 18:02:54 ifi-idsd-phantom sudo[29349]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 18:02:54 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 18:02:54 ifi-idsd-phantom sudo[29349]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.264 D zc pump:mDNS :963 mdns_pump mDNS: Read 264 bytes from socket Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.264 D zc pump:mDNS :339 mdns_parse_questions ignoring packet with flags 0x8400 Oct 15 18:02:55 ifi-idsd-phantom node[459]: ConvSwitch: Add client roon-ready Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::setRepeat null single undefined Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::pushState Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioPushState Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::setRandom null Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::pushState Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioPushState Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: Starting RoonReady Sync Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :963 mdns_pump mDNS: Read 237 bytes from socket Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :343 mdns_parse_questions read packet with question 4 flags 0x0 Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :377 mdns_parse_questions read question for ifi-phmidsd-iDSD PHANTOM [FC:B5:85:E8:CD:D9]-D10C._iFi._tcp.local. (0x21) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :206 mdns_service_match match ifi-phmidsd-iDSD PHANTOM [FC:B5:85:E8:CD:D9]-D10C._iFi._tcp.local. (66) with 46:85:0d:1d:b0:45 (17) _spotify-connect._tcp.local. (28) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :215 mdns_service_match match ifi-phmidsd-iDSD PHANTOM [FC:B5:85:E8:CD:D9]-D10C._iFi._tcp.local. (66) with _spotify-connect._tcp.local. (28) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :227 mdns_service_match match ifi-phmidsd-iDSD PHANTOM [FC:B5:85:E8:CD:D9]-D10C._iFi._tcp.local. (66) with _services._dns-sd._udp.local. (29) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :429 mdns_parse_questions ignored, not matching service filter Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :377 mdns_parse_questions read question for ifi-idsd-phantom.local. (0x1c) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :383 mdns_parse_questions ignored, unrecognized question type 1c Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :377 mdns_parse_questions read question for ifi-idsd-phantom.local. (0x1) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :206 mdns_service_match match ifi-idsd-phantom.local. (23) with 46:85:0d:1d:b0:45 (17) _spotify-connect._tcp.local. (28) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :215 mdns_service_match match ifi-idsd-phantom.local. (23) with _spotify-connect._tcp.local. (28) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :227 mdns_service_match match ifi-idsd-phantom.local. (23) with _services._dns-sd._udp.local. (29) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.799 D zc pump:mDNS :429 mdns_parse_questions ignored, not matching service filter Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.800 D zc pump:mDNS :377 mdns_parse_questions read question for ifi-phmidsd-iDSD PHANTOM [FC:B5:85:E8:CD:D9]-D10C._iFi._tcp.local. (0x10) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.800 D zc pump:mDNS :206 mdns_service_match match ifi-phmidsd-iDSD PHANTOM [FC:B5:85:E8:CD:D9]-D10C._iFi._tcp.local. (66) with 46:85:0d:1d:b0:45 (17) _spotify-connect._tcp.local. (28) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.800 D zc pump:mDNS :215 mdns_service_match match ifi-phmidsd-iDSD PHANTOM [FC:B5:85:E8:CD:D9]-D10C._iFi._tcp.local. (66) with _spotify-connect._tcp.local. (28) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.800 D zc pump:mDNS :227 mdns_service_match match ifi-phmidsd-iDSD PHANTOM [FC:B5:85:E8:CD:D9]-D10C._iFi._tcp.local. (66) with _services._dns-sd._udp.local. (29) Oct 15 18:02:55 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:55.800 D zc pump:mDNS :429 mdns_parse_questions ignored, not matching service filter Oct 15 18:02:55 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 15 18:02:55 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 15 18:02:55 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:55 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 15 18:02:55 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 15 18:02:55 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:55 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 15 18:02:55 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 15 18:02:55 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 15 18:02:55 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:55 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 15 18:02:55 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 15 18:02:55 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:55 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 15 18:02:55 ifi-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.000F/input/input13 Oct 15 18:02:55 ifi-idsd-phantom sudo[29419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Oct 15 18:02:55 ifi-idsd-phantom sudo[29419]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:55 ifi-idsd-phantom sudo[29428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Oct 15 18:02:55 ifi-idsd-phantom sudo[29428]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: ConvSwitch: Get message: request:pause Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioStop Oct 15 18:02:55 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::stop Oct 15 18:02:55 ifi-idsd-phantom kernel: hid-generic 0003:20B1:3008.000F: input,hidraw0: USB HID v1.11 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input4 Oct 15 18:02:55 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 15 18:02:55 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 15 18:02:55 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:55 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 15 18:02:55 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioStop Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::stop Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: Airplay2 Started Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: error: Could not retrieve plugin music_service airplay1_switch Oct 15 18:02:56 ifi-idsd-phantom sudo[29434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Oct 15 18:02:56 ifi-idsd-phantom sudo[29434]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom node[459]: ConvSwitch: Drop client qobuz-connect Oct 15 18:02:56 ifi-idsd-phantom node[490]: Closing connection with the client qobuz-connect Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.086 D zc pump:mDNS :963 mdns_pump mDNS: Read 258 bytes from socket Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.086 D zc pump:mDNS :339 mdns_parse_questions ignoring packet with flags 0x8400 Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Oct 15 18:02:56 ifi-idsd-phantom node[459]: ConvSwitch: Drop client roon-ready Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: Disabling plugin airplay1_switch Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: Done. Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: RoonReady Started Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Roon Ready Service... Oct 15 18:02:56 ifi-idsd-phantom systemd-udevd[29431]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Oct 15 18:02:56 ifi-idsd-phantom sudo[29448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Oct 15 18:02:56 ifi-idsd-phantom sudo[29448]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: MPD Permissions set Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: MPD Permissions set Oct 15 18:02:56 ifi-idsd-phantom sudo[29428]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:56 ifi-idsd-phantom sudo[29452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Oct 15 18:02:56 ifi-idsd-phantom sudo[29452]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom sudo[29458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Oct 15 18:02:56 ifi-idsd-phantom sudo[29458]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: verbose: New Socket.io Connection to 192.168.31.178 from 192.168.31.64 UA: okhttp/3.12.11 Engine version: 3 Transport: websocket Total Clients: 2 Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: Starting Music Player Daemon... Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.381 E esdk pump:SocketManager :652 CallbackPump select error: 4 -> Interrupted system call Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Spotify Connect Service... Oct 15 18:02:56 ifi-idsd-phantom node[459]: ConvSwitch: Drop client spotify Oct 15 18:02:56 ifi-idsd-phantom node[490]: Closing connection with the client spotify Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.391 I app api /usr/src/app/volumio3/spotify/spotify-connect/examples/example_delivery.c:393 main Exiting with error = 0 Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.391 I api api :79 SpFree SpFree() Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.391 D esdk event:KORN_SHUTDOWN :466 sp_korn_dispatch_event [0] Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.391 D zc event:KORN_SHUTDOWN :857 mdns_announce mDNS: Write announce, 5 records, ttl = 0 Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.391 D zc event:KORN_SHUTDOWN :491 mdns_send_impl mDNS: Write reply with 0 question 2 answer 0 authority 3 additional flags 0x8400 Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.391 D zc event:KORN_SHUTDOWN :543 mdns_send_impl write answer PTR _spotify-connect._tcp.local. 46:85:0d:1d:b0:45._spotify-connect._tcp.local. Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.391 D zc event:KORN_SHUTDOWN :528 mdns_send_impl write answer PTR _services._dns-sd._udp.local. _spotify-connect._tcp.local. Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.391 D zc event:KORN_SHUTDOWN :587 mdns_send_impl write additn SRV 46:85:0d:1d:b0:45._spotify-connect._tcp.local. 46:85:0d:1d:b0:45.local. port 5566 ttl 0 Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.391 D zc event:KORN_SHUTDOWN :635 mdns_send_impl write additn TXT 46:85:0d:1d:b0:45._spotify-connect._tcp.local. CPath=/zc VERSION=1.0 Stack=SP ttl 0 Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.391 D zc event:KORN_SHUTDOWN :676 mdns_send_impl write additn A 46:85:0d:1d:b0:45.local. 178.31.168.192 ttl 0 Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.392 D zc event:KORN_SHUTDOWN :711 mdns_send_impl mDNS: wrote 205 bytes to socket Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.392 D zc event:KORN_SHUTDOWN :862 mdns_announce mDNS: Write announce complete Oct 15 18:02:56 ifi-idsd-phantom play[23274]: 2026-10-15 18:02:56.393 I api :81 SpFree SpFree [returned value: 0] Oct 15 18:02:56 ifi-idsd-phantom play[23274]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Oct 15 18:02:56 ifi-idsd-phantom play[23274]: [Info] ConvSwitch: ConvSwitchInit Oct 15 18:02:56 ifi-idsd-phantom play[23274]: [Info] MetaClient: MetaClient SDK -- v1.03 Oct 15 18:02:56 ifi-idsd-phantom play[23274]: [Info] MetaClient: MetaClientInit Oct 15 18:02:56 ifi-idsd-phantom play[23274]: [Info] ConvSwitch: ConvSwitchExit Oct 15 18:02:56 ifi-idsd-phantom play[23274]: [Info] MetaClient: MetaClientExit Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Oct 15 18:02:56 ifi-idsd-phantom sudo[29419]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Oct 15 18:02:56 ifi-idsd-phantom play[29466]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: Roon Ready playback start Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioStop Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::stop Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: Starting Roon Ready metadata receiver Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: Error adding Membership: Error: addMembership EINVAL Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: shairport-sync.service: Succeeded. Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Spotify Connect Service. Oct 15 18:02:56 ifi-idsd-phantom sudo[29448]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:56 ifi-idsd-phantom sudo[29452]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 15 18:02:56 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 15 18:02:56 ifi-idsd-phantom sudo[29464]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 18:02:56 ifi-idsd-phantom sudo[29464]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:56 ifi-idsd-phantom sudo[29464]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: Started iFi Streamer Spotify Connect Service. Oct 15 18:02:56 ifi-idsd-phantom sudo[29434]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: mpd.service: Succeeded. Oct 15 18:02:56 ifi-idsd-phantom systemd[1]: Stopped Music Player Daemon. Oct 15 18:02:56 ifi-idsd-phantom sudo[29458]: pam_unix(sudo:session): session closed for user root Oct 15 18:02:56 ifi-idsd-phantom ifi_metadata[29305]: [Info] MetaClient: MetaClient SDK -- v1.03 Oct 15 18:02:56 ifi-idsd-phantom ifi_metadata[29305]: [Info] MetaClient: MetaClientInit Oct 15 18:02:56 ifi-idsd-phantom ifi_metadata[29305]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Oct 15 18:02:56 ifi-idsd-phantom ifi_metadata[29305]: [Info] ConvSwitch: ConvSwitchInit Oct 15 18:02:56 ifi-idsd-phantom ifi_metadata[29305]: Could not connect: Reason::CONNECTION_ERROR Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:56 ifi-idsd-phantom play[29478]: iDSD_PHANTOM Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioGetQueue Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::getQueue Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getQueue Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CURURI: music-library/USB Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioGetState Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::getTrack 0 Oct 15 18:02:56 ifi-idsd-phantom play[29478]: output: volumio mixer: hw:0 Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: Preload queue cleared Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::ClearQueue Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::stop Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::clearPlayQueue Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::saveQueue Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreCommandRouter::volumioPushQueue Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CoreStateMachine::addQueueItems Oct 15 18:02:56 ifi-idsd-phantom node[459]: ConvSwitch: Add client spotify Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: CorePlayQueue::addQueueItems Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: Preload queue cleared Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: Adding Item to queue: music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/1.Goldeneye (From _Goldeneye_).flac Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: info: Exploding uri music-library/USB/A0CC-7B51/当古典乐遇见电影 Shaken Not Stirred/1.Goldeneye (From _Goldeneye_).flac in service mpd Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 18:02:56 ifi-idsd-phantom node[490]: A new connection has been established. Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: TypeError: Cannot read property 'then' of undefined Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2898:19) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2696:21) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1536:16) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:214:19) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:256:30) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:314:25) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:636:25) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:608:19) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:180:33) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at Socket.emit (events.js:400:28) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Oct 15 18:02:56 ifi-idsd-phantom volumio[28839]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.990 I api :141 SpRegisterDebugCallbacks SpRegisterDebugCallbacks [returned value: 0] Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.991 I api :57 SpInit SpInit(0xfffe1de0, API v85) Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.991 I esdk :1740 esdkSpInit eSDK version: esdk-v3.211-v3.211.126-g38bc1087 Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.991 T esdk :256 sp_korn_request_memory_block Module requested 600 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.991 T esdk :256 sp_korn_request_memory_block Module requested 184 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.991 T esdk :256 sp_korn_request_memory_block Module requested 200 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.991 T esdk :358 sp_korn_init_module Initializing module SocketManager Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.991 T esdk :256 sp_korn_request_memory_block Module requested 112 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.991 T esdk :358 sp_korn_init_module Initializing module API Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.991 T esdk :256 sp_korn_request_memory_block Module requested 3560 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.991 T esdk api :358 sp_korn_init_module Initializing module MediaOut Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.991 T esdk api :256 sp_korn_request_memory_block Module requested 136 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.992 T esdk api :256 sp_korn_request_memory_block Module requested 2344 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.992 T esdk api :256 sp_korn_request_memory_block Module requested 40 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.992 T esdk api :256 sp_korn_request_memory_block Module requested 976 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.992 D esdk api :2005 sp_module_media_out_init raise EXTERNAL_STUTTERS_POINTER Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.992 D esdk api :2007 sp_module_media_out_init raise PREVIOUS_POSITION Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.992 T esdk api :358 sp_korn_init_module Initializing module APConn Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.992 T esdk api :256 sp_korn_request_memory_block Module requested 26784 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.992 T esdk api :256 sp_korn_request_memory_block Module requested 25160 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.992 T esdk api :256 sp_korn_request_memory_block Module requested 56 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.992 T esdk api :256 sp_korn_request_memory_block Module requested 1040 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.992 D esdk api :1140 sp_module_ap_conn_init raise AP_CREATED Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.993 T esdk api :358 sp_korn_init_module Initializing module Streamer Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.993 T esdk api :256 sp_korn_request_memory_block Module requested 8472 bytes Oct 15 18:02:56 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.993 D esdk api :1419 sp_module_streamer_init raise STREAMER_TRACK_PERCENTAGE Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.994 T esdk api :358 sp_korn_init_module Initializing module TrackPlayback Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.994 T esdk api :256 sp_korn_request_memory_block Module requested 214848 bytes Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.994 D esdk api :3390 sp_module_track_playback_init raise TPAPI_SHARED_STATE_POINTER Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.994 T esdk api :358 sp_korn_init_module Initializing module mDNS Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.994 T zc api :39 sp_module_mdns_init Request memory block of 1 KiB for mDNS module Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.994 T esdk api :256 sp_korn_request_memory_block Module requested 1536 bytes Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.994 T esdk api :358 sp_korn_init_module Initializing module WebServer Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.994 T zc api :34 sp_module_webserver_init Request memory block of 2 KiB for webserver module Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 T esdk api :256 sp_korn_request_memory_block Module requested 2048 bytes Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 T esdk api :358 sp_korn_init_module Initializing module ZeroConfServer Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 T zc api :21 sp_module_zeroconf_init Request memory block of 0 KiB for zeroconf module Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 T esdk api :256 sp_korn_request_memory_block Module requested 8 bytes Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 I esdk api :353 register_socket_callbacks 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 Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 I esdk api :333 register_dns_callbacks Successfully registered dns callback: dns_lookup_callback Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 D esdk event:EXTERNAL_STUTTERS_POINTER :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 D esdk event:PREVIOUS_POSITION :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 D esdk event:AP_CREATED :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 D esdk event:STREAMER_TRACK_PERCENTAGE :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 D esdk event:TPAPI_SHARED_STATE_POINTE :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom node[459]: ConvSwitch: Add client roon-ready Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 D esdk event:KORN_INITIALIZED :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 I download event:KORN_INITIALIZED :211 alloc_circular_buffer Using 128 kB for cache buffer Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 T esdk event:KORN_INITIALIZED :256 sp_korn_request_memory_block Module requested 131072 bytes Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 I download event:KORN_INITIALIZED :211 alloc_circular_buffer Using 606 kB for compressed audio buffer Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 T esdk event:KORN_INITIALIZED :256 sp_korn_request_memory_block Module requested 621104 bytes Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 I api api :1295 SpGetDefaultSocketHALCallbacks SpGetDefaultSocketHALCallbacks() Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:56.995 I api api :1297 SpGetDefaultSocketHALCallbacks SpGetDefaultSocketHALCallbacks [returned value: 0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.006 D esdk api :1798 esdkSpInit raise REDELIVER_AUDIO_AT_RESUME Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.007 I esdk api :445 register_error_callbacks Successfully registered error callback Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.007 D esdk api :1809 esdkSpInit raise SET_VOLUME Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.007 D esdk api :1812 esdkSpInit raise VOLUME_STEPS Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.007 D esdk api :3510 esdkSpSetDisplayName raise CONNECT_NAME Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.007 D esdk api :1519 save_session_config raise GROUP_STATE Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.007 D esdk api :1845 esdkSpInit raise UPDATE_CAPABILITIES Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.007 D esdk api :1866 esdkSpInit raise CONNECTIVITY Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.022 D esdk api :1889 esdkSpInit raise HOSTNAME Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.022 D esdk api :1897 esdkSpInit raise UPDATE_ALIASES Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.022 D esdk api :1899 esdkSpInit raise ZEROCONF_START Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.022 D esdk api :1921 esdkSpInit raise REQUEST_BITRATE Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk api :1924 esdkSpInit raise DISABLE_CONNECT Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk api :1927 esdkSpInit raise INIT_DONE Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:REDELIVER_AUDIO_AT_RESUME :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:SET_VOLUME :466 sp_korn_dispatch_event [32768] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:VOLUME_STEPS :466 sp_korn_dispatch_event [16] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:CONNECT_NAME :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:GROUP_STATE :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:UPDATE_CAPABILITIES :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 I esdk event:UPDATE_CAPABILITIES :2921 track_playback_event Updated capabilities = 1, updated formats = 1 Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:CONNECTIVITY :466 sp_korn_dispatch_event [1] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:CONNECTIVITY :1088 ap_conn_event raise CONNECTION_STATE_CHANGED Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:HOSTNAME :466 sp_korn_dispatch_event [17] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:UPDATE_ALIASES :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:ZEROCONF_START :466 sp_korn_dispatch_event [364773376] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:ZEROCONF_START :48 zeroconf_mod_event raise WEBSERVER_START Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:REQUEST_BITRATE :466 sp_korn_dispatch_event [3] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 T audio event:REQUEST_BITRATE :54 get_pos_from_integration track_id 0, provided_to_integration 0, is_seeking 0 Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:DISABLE_CONNECT :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:INIT_DONE :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:CONNECTION_STATE_CHANGED :466 sp_korn_dispatch_event [1] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 I esdk event:CONNECTION_STATE_CHANGED :569 handle_connection_state_change Connection state changed: 1 -> 1 Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:CONNECTION_STATE_CHANGED :125 webserver_mod_event raise WEBSERVER_UPDATED Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 D esdk event:WEBSERVER_START :466 sp_korn_dispatch_event [364773376] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.023 I esdk event:WEBSERVER_START :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.024 I zc event:WEBSERVER_START :484 webserver_initialize webserver: service port 5566 (5566-5566) buffer size 1880 Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.024 T zc event:WEBSERVER_START :60 webserver_mod_start webserver_initialize() = 0xf5b43de8 Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.024 D esdk event:WEBSERVER_START :63 webserver_mod_start raise WEBSERVER_STARTED Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.024 D esdk event:WEBSERVER_UPDATED :466 sp_korn_dispatch_event [0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.024 D esdk event:WEBSERVER_STARTED :466 sp_korn_dispatch_event [5566] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.024 D zc event:WEBSERVER_STARTED :583 webserver_bind bound path "/zc" Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.024 I zc event:WEBSERVER_STARTED :54 zeroconf_mod_event Started ZeroConf service on port 5566 path /zc Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.024 D esdk event:WEBSERVER_STARTED :59 zeroconf_mod_event raise MDNS_START Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.024 D esdk event:MDNS_START :466 sp_korn_dispatch_event [5566] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.024 I esdk event:MDNS_START :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.024 D zc event:MDNS_START :928 mdns_initialize mDNS: service port 5566 path /zc buffer size 1264 Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.024 T zc event:MDNS_START :69 mdns_mod_start mdns_initialize() = 0xf5b437f0 Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.025 I api api :59 SpInit SpInit [returned value: 0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.025 I api api :91 SpRegisterConnectionCallbacks SpRegisterConnectionCallbacks(0xfffe1dd4, (nil)) Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.025 I esdk api :271 register_connection_callbacks Successfully registered connection callbacks: on_notify, on_message, - Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.025 I api api :93 SpRegisterConnectionCallbacks SpRegisterConnectionCallbacks [returned value: 0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.025 I api api :115 SpRegisterPlaybackCallbacks SpRegisterPlaybackCallbacks(0xfffe1dc4, (nil)) Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.025 I esdk api :184 register_playback_callbacks Successfully registered playback callbacks: on_notify, -, on_apply_volume Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.025 I api api :117 SpRegisterPlaybackCallbacks SpRegisterPlaybackCallbacks [returned value: 0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.061 W app api /usr/src/app/volumio3/spotify/spotify-connect/examples/common/audio/linux_alsa.c:471 audio_init Couldn't find mixer for volume controls. (tried Master, PCM, Digital) Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.061 I api api :127 SpRegisterStreamCallbacks SpRegisterStreamCallbacks(0xfffe0e10, 0x368a0) Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.061 I esdk api :203 register_stream_callbacks Successfully registered delivery callbacks: on_start, on_data, on_pos, on_seek, on_flush, on_end Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.061 I api api :129 SpRegisterStreamCallbacks SpRegisterStreamCallbacks [returned value: 0] Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.061 I app api /usr/src/app/volumio3/spotify/spotify-connect/examples/example_delivery.c:273 main Initialized! Oct 15 18:02:57 ifi-idsd-phantom tidal_connect_application[29479]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 18:02:57 ifi-idsd-phantom tidal_connect_application[29479]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 18:02:57 ifi-idsd-phantom tidal_connect_application[29479]: *** WARNING *** For more information see Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.271 D zc pump:mDNS :963 mdns_pump mDNS: Read 215 bytes from socket Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.271 D zc pump:mDNS :343 mdns_parse_questions read packet with question 1 flags 0x0 Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.272 D zc pump:mDNS :377 mdns_parse_questions read question for iFi Streamer-366b5988034c00365b10823170bae64a._tidalconnect._tcp.local. (0xff) Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.272 D zc pump:mDNS :383 mdns_parse_questions ignored, unrecognized question type ff Oct 15 18:02:57 ifi-idsd-phantom ifi_metadata[29305]: Connected Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.522 D zc pump:mDNS :963 mdns_pump mDNS: Read 215 bytes from socket Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.522 D zc pump:mDNS :343 mdns_parse_questions read packet with question 1 flags 0x0 Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.522 D zc pump:mDNS :377 mdns_parse_questions read question for iFi Streamer-366b5988034c00365b10823170bae64a._tidalconnect._tcp.local. (0xff) Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.522 D zc pump:mDNS :383 mdns_parse_questions ignored, unrecognized question type ff Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.773 D zc pump:mDNS :963 mdns_pump mDNS: Read 215 bytes from socket Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.773 D zc pump:mDNS :343 mdns_parse_questions read packet with question 1 flags 0x0 Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.773 D zc pump:mDNS :377 mdns_parse_questions read question for iFi Streamer-366b5988034c00365b10823170bae64a._tidalconnect._tcp.local. (0xff) Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.773 D zc pump:mDNS :383 mdns_parse_questions ignored, unrecognized question type ff Oct 15 18:02:57 ifi-idsd-phantom sudo[29585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-15 18:01 Oct 15 18:02:57 ifi-idsd-phantom sudo[29585]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.974 D zc pump:mDNS :963 mdns_pump mDNS: Read 276 bytes from socket Oct 15 18:02:57 ifi-idsd-phantom play[29478]: 2026-10-15 18:02:57.975 D zc pump:mDNS :339 mdns_parse_questions ignoring packet with flags 0x8400 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="88e690d6ca5d6a2e79f6a44738742624d952a43a" VOLUMIO_FE_VERSION="54aae9b0cae30f0ee38854e39b8ffa94a10c6061" VOLUMIO_FE3_VERSION="3455c2f8b3002f05c48a603a2e136bbb2d6d8a01" VOLUMIO_BE_VERSION="4520fceff198b992cfeeced04a97e9c8db23e62d" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="ifi" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Apr 23 16:08:18 CST 2026" VOLUMIO_VERSION="2.03.4" VOLUMIO_HARDWARE="idsd-phantom" VOLUMIO_DEVICENAME="iDSD PHANTOM" VOLUMIO_HASH="7939bd38f2009022f84d72d48dbcb3a0"