-- Logs begin at Mon 2025-10-27 01:07:37 UTC, end at Mon 2025-10-27 03:08:07 UTC. --
Oct 27 03:07:02 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 27 03:07:02 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 27 03:07:02 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 27 03:07:02 ifi-idsd-phantom volumio[7829]: error: Could not retrieve plugin system_controller my_volumio
Oct 27 03:07:05 ifi-idsd-phantom kernel: 379e
Oct 27 03:07:05 ifi-idsd-phantom kernel: press DSD2048
Oct 27 03:07:05 ifi-idsd-phantom kernel: 3f9e
Oct 27 03:07:05 ifi-idsd-phantom kernel: release DSD2048
Oct 27 03:07:06 ifi-idsd-phantom kernel: 379e
Oct 27 03:07:06 ifi-idsd-phantom kernel: press DSD2048
Oct 27 03:07:06 ifi-idsd-phantom kernel: 3f9e
Oct 27 03:07:06 ifi-idsd-phantom kernel: release DSD2048
Oct 27 03:07:07 ifi-idsd-phantom ethernet-detect[503]: No change in avahi-daemon interfaces. Skipping restart.
Oct 27 03:07:10 ifi-idsd-phantom kernel: 3d9e
Oct 27 03:07:10 ifi-idsd-phantom kernel: press xspace
Oct 27 03:07:11 ifi-idsd-phantom kernel: 3f9e
Oct 27 03:07:11 ifi-idsd-phantom kernel: release xspace
Oct 27 03:07:12 ifi-idsd-phantom kernel: 3e9e
Oct 27 03:07:12 ifi-idsd-phantom kernel: press k2
Oct 27 03:07:12 ifi-idsd-phantom kernel: 3f9e
Oct 27 03:07:12 ifi-idsd-phantom kernel: release k2
Oct 27 03:07:13 ifi-idsd-phantom kernel: 3b9e
Oct 27 03:07:13 ifi-idsd-phantom kernel: press xbass
Oct 27 03:07:13 ifi-idsd-phantom kernel: 3f9e
Oct 27 03:07:13 ifi-idsd-phantom kernel: release xbass
Oct 27 03:07:17 ifi-idsd-phantom ethernet-detect[503]: No change in avahi-daemon interfaces. Skipping restart.
Oct 27 03:07:27 ifi-idsd-phantom ethernet-detect[503]: No change in avahi-daemon interfaces. Skipping restart.
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: ++++--++++ pause
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPause
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pause
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::stPlaybackTimer
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::servicePause
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePause
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pause
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand pause
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand pause took 9 milliseconds
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 18 milliseconds
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 12 milliseconds
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 7 milliseconds
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand playlistinfo took 17 milliseconds
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand playlistinfo took 14 milliseconds
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand playlistinfo took 10 milliseconds
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseTrackInfo
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseTrackInfo
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseTrackInfo
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pushState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePushState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":43242,"duration":183,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"(DSD64)Divertimento DSD.dff","artist":null,"album":null,"uri":"NAS/testmusic/(DSD64)Divertimento DSD.dff","trackType":"dff"}
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: CURRENT POSITION 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   stateService pause
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   currentStatus pause
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::stPlaybackTimer
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pushState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePushState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":43242,"duration":183,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"(DSD64)Divertimento DSD.dff","artist":null,"album":null,"uri":"NAS/testmusic/(DSD64)Divertimento DSD.dff","trackType":"dff"}
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: CURRENT POSITION 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   stateService pause
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   currentStatus pause
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::stPlaybackTimer
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pushState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePushState
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":43242,"duration":183,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"(DSD64)Divertimento DSD.dff","artist":null,"album":null,"uri":"NAS/testmusic/(DSD64)Divertimento DSD.dff","trackType":"dff"}
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: verbose: CURRENT POSITION 5
Oct 27 03:07:30 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 27 03:07:31 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   stateService pause
Oct 27 03:07:31 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   currentStatus pause
Oct 27 03:07:31 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:31 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:31 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:31 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:31 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::stPlaybackTimer
Oct 27 03:07:31 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 264ms
Oct 27 03:07:31 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 259ms
Oct 27 03:07:31 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 255ms
Oct 27 03:07:31 ifi-idsd-phantom volumio[7829]: info: Discovery: Disconnected from remote: 192.168.1.172
Oct 27 03:07:31 ifi-idsd-phantom volumio[7829]: error: Could not retrieve plugin audio_interface multiroom
Oct 27 03:07:37 ifi-idsd-phantom ethernet-detect[503]: No change in avahi-daemon interfaces. Skipping restart.
Oct 27 03:07:37 ifi-idsd-phantom volumio[7829]: info: Discovery: Remote connection error: 192.168.1.172
Oct 27 03:07:37 ifi-idsd-phantom volumio[7829]: info: Discovery: Remote connection timeout: 192.168.1.172
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 18 milliseconds
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 14 milliseconds
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 9 milliseconds
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand playlistinfo took 16 milliseconds
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand playlistinfo took 13 milliseconds
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand playlistinfo took 9 milliseconds
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseTrackInfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseTrackInfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseTrackInfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":183,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"(DSD64)Divertimento DSD.dff","artist":null,"album":null,"uri":"NAS/testmusic/(DSD64)Divertimento DSD.dff","trackType":"dff"}
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: CURRENT POSITION 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   stateService pause
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   currentStatus pause
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::stPlaybackTimer
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":183,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"(DSD64)Divertimento DSD.dff","artist":null,"album":null,"uri":"NAS/testmusic/(DSD64)Divertimento DSD.dff","trackType":"dff"}
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: CURRENT POSITION 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   stateService pause
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   currentStatus pause
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::stPlaybackTimer
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":183,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"(DSD64)Divertimento DSD.dff","artist":null,"album":null,"uri":"NAS/testmusic/(DSD64)Divertimento DSD.dff","trackType":"dff"}
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: CURRENT POSITION 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   stateService pause
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   currentStatus pause
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::stPlaybackTimer
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 264ms
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 249ms
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 246ms
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: Clearing queue after UPNP request
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::ClearQueue
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::stop
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::updateTrackBlock
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrackBlock
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::stPlaybackTimer
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::serviceStop
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::serviceStop
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::stop
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand stop
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::clearPlayQueue
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::saveQueue
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushQueue
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand stop took 68 milliseconds
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 22 milliseconds
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 17 milliseconds
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 12 milliseconds
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: verbose: CURRENT POSITION 5
Oct 27 03:07:40 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pushState
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePushState
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: verbose: CURRENT POSITION 5
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pushState
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePushState
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: verbose: CURRENT POSITION 5
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 164ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 157ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 153ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: error: updateQueue error: null
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: error: updateQueue error: null
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: error: updateQueue error: null
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 166ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 20ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 16ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Starting UPNP Playback
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ConvSwitch: Sent Play
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Preparing playback through UPNP
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getTrack 5
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ConvSwitch: Get message: success
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 23ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 16ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 11ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 21ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 15ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 11ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 22ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 16ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 11ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 16ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 11ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 8ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 16ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 12ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 10ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces system playlist update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Ignoring MPD Status Update
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 27ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 23ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 9ms
Oct 27 03:07:41 ifi-idsd-phantom volumio[7829]: info: Discovery: Remote connection error: 192.168.1.172
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:42 ifi-idsd-phantom kernel: GAIN_0dB
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 108 milliseconds
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 100 milliseconds
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 99 milliseconds
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand playlistinfo took 47 milliseconds
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand playlistinfo took 32 milliseconds
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand playlistinfo took 24 milliseconds
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseTrackInfo
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseTrackInfo
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseTrackInfo
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: In UPNP mode
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":441,"samplerate":"8 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"悬溺","artist":"葛东琪","album":"第二街区","uri":"http://m801.music.126.net/20251027113240/0b7820b8c7fda35a595dde79598ff835/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/34566876038/5eeb/efa8/52d9/4f8279e780c4cb65655534e4d6a08d93.m4a?vuutv=jxS0OE3kJpsetMTSGGKdEXxNXfAqvxW3pxj9EuJrvuJdht3frdJTqy+mfjSu1tJrPSKepMz1v15oz1q2Ip1+jW7gWFkU5/FcRfZkGVPL8Ds=","trackType":""}
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: CURRENT POSITION 5
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   stateService play
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   currentStatus stop
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: In UPNP mode
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":441,"samplerate":"8 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"悬溺","artist":"葛东琪","album":"第二街区","uri":"http://m801.music.126.net/20251027113240/0b7820b8c7fda35a595dde79598ff835/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/34566876038/5eeb/efa8/52d9/4f8279e780c4cb65655534e4d6a08d93.m4a?vuutv=jxS0OE3kJpsetMTSGGKdEXxNXfAqvxW3pxj9EuJrvuJdht3frdJTqy+mfjSu1tJrPSKepMz1v15oz1q2Ip1+jW7gWFkU5/FcRfZkGVPL8Ds=","trackType":""}
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: CURRENT POSITION 5
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   stateService play
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   currentStatus play
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: Received an update from plugin. extracting info from payload
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::pushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::servicePushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: In UPNP mode
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":441,"samplerate":"8 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"悬溺","artist":"葛东琪","album":"第二街区","uri":"http://m801.music.126.net/20251027113240/0b7820b8c7fda35a595dde79598ff835/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/34566876038/5eeb/efa8/52d9/4f8279e780c4cb65655534e4d6a08d93.m4a?vuutv=jxS0OE3kJpsetMTSGGKdEXxNXfAqvxW3pxj9EuJrvuJdht3frdJTqy+mfjSu1tJrPSKepMz1v15oz1q2Ip1+jW7gWFkU5/FcRfZkGVPL8Ds=","trackType":""}
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: verbose: CURRENT POSITION 5
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   stateService play
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::syncState   currentStatus play
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: Received an update from plugin. extracting info from payload
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::pushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:42 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 525ms
Oct 27 03:07:42 ifi-idsd-phantom demo[810]: [send_message 4011848768] 1761534462.940: enter client=0xf1298 sock=8 msg='Filter_ui_index:0'
Oct 27 03:07:42 ifi-idsd-phantom demo[810]: [send_message 4011848768] 1761534462.940: enter client=0xf1298 sock=8 msg='k2_ui:0'
Oct 27 03:07:42 ifi-idsd-phantom demo[810]: [send_message 4011848768] 1761534462.940: enter client=0xf1298 sock=8 msg='Dsd_ui_index:0'
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 642ms
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: ------------------------------ 637ms
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info:
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: ---------------------------- MPD announces state update: player
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: ControllerMpd::getState
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand status
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 503 milliseconds
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: sendMpdCommand status took 12 milliseconds
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::parseState
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetQueue
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::getQueue
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getQueue
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetQueue
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::getQueue
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getQueue
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetQueue
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::getQueue
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getQueue
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CoreCommandRouter::volumioGetQueue
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CoreStateMachine::getQueue
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: info: CorePlayQueue::getQueue
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: TypeError: Cannot read property 'logger' of undefined
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]:     at /volumio/app/statemachine.js:629:16
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]:     at ChildProcess.exithandler (child_process.js:390:5)
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]:     at ChildProcess.emit (events.js:400:28)
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]:     at maybeClose (internal/child_process.js:1088:16)
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]:     at Socket. (internal/child_process.js:446:11)
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]:     at Socket.emit (events.js:400:28)
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]:     at Pipe. (net.js:686:12)
Oct 27 03:07:43 ifi-idsd-phantom volumio[7829]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 27 03:07:44 ifi-idsd-phantom sudo[11156]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-27 03:06
Oct 27 03:07:44 ifi-idsd-phantom sudo[11156]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:44 ifi-idsd-phantom sudo[11156]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:44 ifi-idsd-phantom node[498]: ConvSwitch: Drop client volumio
Oct 27 03:07:44 ifi-idsd-phantom systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 03:07:44 ifi-idsd-phantom node[513]: Closing connection with the client volumio
Oct 27 03:07:44 ifi-idsd-phantom systemd[1]: volumio.service: Failed with result 'exit-code'.
Oct 27 03:07:44 ifi-idsd-phantom systemd[1]: Started dynamicswap service.
Oct 27 03:07:44 ifi-idsd-phantom systemd[1]: dynamicswap.service: Succeeded.
Oct 27 03:07:44 ifi-idsd-phantom systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Oct 27 03:07:44 ifi-idsd-phantom systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1.
Oct 27 03:07:44 ifi-idsd-phantom systemd[1]: Started dynamicswap service.
Oct 27 03:07:44 ifi-idsd-phantom systemd[1]: Stopped Volumio Backend Module.
Oct 27 03:07:44 ifi-idsd-phantom systemd[1]: Started Volumio Backend Module.
Oct 27 03:07:44 ifi-idsd-phantom systemd[1]: dynamicswap.service: Succeeded.
Oct 27 03:07:47 ifi-idsd-phantom kernel: unmute_store
Oct 27 03:07:47 ifi-idsd-phantom ethernet-detect[503]: No change in avahi-daemon interfaces. Skipping restart.
Oct 27 03:07:48 ifi-idsd-phantom volumio[11173]: info: -------------------------------------------
Oct 27 03:07:48 ifi-idsd-phantom volumio[11173]: info: -----            Volumio3              ----
Oct 27 03:07:48 ifi-idsd-phantom volumio[11173]: info: -------------------------------------------
Oct 27 03:07:48 ifi-idsd-phantom volumio[11173]: info: -----          System startup          ----
Oct 27 03:07:48 ifi-idsd-phantom volumio[11173]: info: -------------------------------------------
Oct 27 03:07:48 ifi-idsd-phantom volumio[11173]: info: ConvSwitch: Client Start
Oct 27 03:07:48 ifi-idsd-phantom volumio[11173]: info: MetaClient: Client Start
Oct 27 03:07:48 ifi-idsd-phantom node[513]: A new connection has been established.
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Plugin folders cleanup
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Scanning into folder /volumio/app/plugins/
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Scanning category audio_interface
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Scanning category miscellanea
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Scanning category music_service
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Scanning category plugins.json
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Scanning category system_controller
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Scanning category user_interface
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Scanning into folder /data/plugins/
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Scanning category music_service
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Plugin folders cleanup completed
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: -------------------------------------------
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: -----      Core plugins startup        ----
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: -------------------------------------------
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Loading plugins from folder /volumio/app/plugins/
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Adding plugin networkaudiod to MyMusic Plugins
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Adding plugin qobuz_connect to MyMusic Plugins
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Adding plugin spotify_connect to MyMusic Plugins
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Adding plugin tidal_connect to MyMusic Plugins
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Adding plugin upnp to MyMusic Plugins
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Adding plugin airplay1_switch to MyMusic Plugins
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Adding plugin airplay2_switch to MyMusic Plugins
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Adding plugin roon_ready to MyMusic Plugins
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Adding plugin upnp_browser to MyMusic Plugins
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Loading plugins from folder /data/plugins/
Oct 27 03:07:49 ifi-idsd-phantom volumio[11173]: info: Loading plugin "system"...
Oct 27 03:07:50 ifi-idsd-phantom volumio[11173]: info: Loading plugin "appearance"...
Oct 27 03:07:51 ifi-idsd-phantom volumio[11173]: info: Loading plugin "network"...
Oct 27 03:07:51 ifi-idsd-phantom volumio[11173]: info: Refreshing Cached IP Addresses
Oct 27 03:07:51 ifi-idsd-phantom sudo[11298]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 27 03:07:51 ifi-idsd-phantom sudo[11298]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:51 ifi-idsd-phantom sudo[11298]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:51 ifi-idsd-phantom sudo[11300]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 27 03:07:51 ifi-idsd-phantom sudo[11300]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:51 ifi-idsd-phantom sudo[11300]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Loading plugin "services"...
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Loading plugin "alsa_controller"...
Oct 27 03:07:52 ifi-idsd-phantom sudo[11309]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Oct 27 03:07:52 ifi-idsd-phantom sudo[11309]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Loading plugin "wizard"...
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Loading plugin "networkfs"...
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS testmusic at system boot, trial number 1 ,retrying in 5 seconds
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS testmusic at system boot, trial number 2 ,retrying in 5 seconds
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS testmusic at system boot, trial number 3 ,retrying in 5 seconds
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Starting Udev Watcher for removable devices
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: error: Cannot associate FS Label, not mounting
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: error: Cannot associate FS Label, not mounting
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Ignoring mount for partition: BOOT
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Ignoring mount for partition: archivefs
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Ignoring mount for partition: rootfs
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Loading plugin "volumio_command_line_client"...
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Loading plugin "networkaudiod"...
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: [1761534472414] Starting NAA Service
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Loading plugin "tidal_connect"...
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: [1761534472446] Starting Tidal Connect Service
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Loading plugin "upnp"...
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: [1761534472460] Starting Upmpd Daemon
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Starting Upmpd Daemon
Oct 27 03:07:52 ifi-idsd-phantom sudo[11333]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart networkaudiod.service
Oct 27 03:07:52 ifi-idsd-phantom sudo[11333]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: error: ATTENTION!!!: Plugin upnp does not return adequate promise from onVolumioStart: please update!
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Loading plugin "my_music"...
Oct 27 03:07:52 ifi-idsd-phantom volumio[11173]: info: Loading plugin "mpd"...
Oct 27 03:07:52 ifi-idsd-phantom systemd[1]: Stopping Network Audio Adapter daemon...
Oct 27 03:07:52 ifi-idsd-phantom systemd[1]: networkaudiod.service: Succeeded.
Oct 27 03:07:52 ifi-idsd-phantom systemd[1]: Stopped Network Audio Adapter daemon.
Oct 27 03:07:52 ifi-idsd-phantom systemd[1]: Started Network Audio Adapter daemon.
Oct 27 03:07:52 ifi-idsd-phantom sudo[11333]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:52 ifi-idsd-phantom networkaudiod[11335]: [/usr/sbin/networkaudiod] (11335): networkaudiod Copyright (C) 2011-2020 Jussi Laako / Signalyst. All rights reserved.
Oct 27 03:07:52 ifi-idsd-phantom networkaudiod[11335]: [/usr/sbin/networkaudiod] (11335): create alsa engine
Oct 27 03:07:52 ifi-idsd-phantom networkaudiod[11335]: [/usr/sbin/networkaudiod] (11335): listen discovery on ::
Oct 27 03:07:52 ifi-idsd-phantom networkaudiod[11335]: [/usr/sbin/networkaudiod] (11335): clSocket::SetOption(): setsockopt(..., 41,20, ...): No such device
Oct 27 03:07:52 ifi-idsd-phantom networkaudiod[11335]: [/usr/sbin/networkaudiod] (11335): Socket failure, falling back to IPv4-only!
Oct 27 03:07:53 ifi-idsd-phantom volumio[11173]: info: Loading plugin "upnp_browser"...
Oct 27 03:07:53 ifi-idsd-phantom networkaudiod[11335]: [/usr/sbin/networkaudiod] (11335): listen discovery on 0.0.0.0
Oct 27 03:07:53 ifi-idsd-phantom volumio[11173]: info: Loading plugin "qobuz_connect"...
Oct 27 03:07:53 ifi-idsd-phantom volumio[11173]: info: [1761534473768] Starting Qobuz Connect Service
Oct 27 03:07:53 ifi-idsd-phantom volumio[11173]: info: Loading plugin "alarm-clock"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "last_100"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "roon_ready"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Starting RoonReady Sync
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "webradio"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "i2s_dacs"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: I2S DAC not set, start Auto-detection
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "volumiodiscovery"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: *** WARNING *** For more information see 
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: *** WARNING *** For more information see 
Oct 27 03:07:54 ifi-idsd-phantom node[11173]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 27 03:07:54 ifi-idsd-phantom node[11173]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 27 03:07:54 ifi-idsd-phantom node[11173]: *** WARNING *** For more information see 
Oct 27 03:07:54 ifi-idsd-phantom node[11173]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 27 03:07:54 ifi-idsd-phantom node[11173]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 27 03:07:54 ifi-idsd-phantom node[11173]: *** WARNING *** For more information see 
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Applying required configuration parameters for plugin volumiodiscovery
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "spotify_connect"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: [1761534474390] Starting Spotify Connect Service
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Plugin airplay1_switch is not enabled
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "airplay2_switch"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "airplay_emulation"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Starting Shairport Sync
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "outputs"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "albumart"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Plugin example_plugin is not enabled
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "inputs"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "updater_comm"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Plugin mpdemulation is not enabled
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "rest_api"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Loading plugin "websocket"...
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Starting Socket.io Server version 2.3.0
Oct 27 03:07:54 ifi-idsd-phantom volumio[11173]: info: Plugin ifi-cdplayer is not enabled
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: Loading i18n strings for locale zh
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: Updating browse sources language
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: Forking 3 albumart workers
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::initPlayerControls
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: Removing existing socket file at /tmp/meta.sock
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: Express server listening on port 3000
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]:  [Metrics]  WebUI:  8s 526.45ms 
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::resetVolumioState
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::getcurrentVolume
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioRetrievevolume
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: Meta server listening
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::pushState
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CorePlayQueue::getTrack 0
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioPushState
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 27 03:07:55 ifi-idsd-phantom volumio[11173]: info: Server listening on port 6599
Oct 27 03:07:55 ifi-idsd-phantom sudo[11410]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service
Oct 27 03:07:55 ifi-idsd-phantom sudo[11410]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:55 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Tidal Metadata Service...
Oct 27 03:07:55 ifi-idsd-phantom node[513]: Closing connection with the client tidal-connect
Oct 27 03:07:55 ifi-idsd-phantom systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM
Oct 27 03:07:55 ifi-idsd-phantom sudo[11418]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service
Oct 27 03:07:55 ifi-idsd-phantom systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded.
Oct 27 03:07:55 ifi-idsd-phantom sudo[11418]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:55 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Tidal Metadata Service.
Oct 27 03:07:56 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Tidal Connect Service...
Oct 27 03:07:56 ifi-idsd-phantom systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM
Oct 27 03:07:56 ifi-idsd-phantom node[498]: ConvSwitch: Drop client tidal
Oct 27 03:07:56 ifi-idsd-phantom systemd[1]: ifi-streamer-tidal-connect.service: Succeeded.
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Oct 27 03:07:56 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Tidal Connect Service.
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: info: Completed loading Core Plugins
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: info: Preparing to generate the ALSA configuration file
Oct 27 03:07:56 ifi-idsd-phantom systemd[1]: Started iFi Streamer Tidal Connect Service.
Oct 27 03:07:56 ifi-idsd-phantom systemd[1]: Started iFi Streamer Tidal Metadata Service.
Oct 27 03:07:56 ifi-idsd-phantom sudo[11410]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:56 ifi-idsd-phantom node[513]: A new connection has been established.
Oct 27 03:07:56 ifi-idsd-phantom sudo[11418]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: info: ConvSwitch: Connected to server
Oct 27 03:07:56 ifi-idsd-phantom node[498]: ConvSwitch: Add client volumio
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: info: MetaClient: Connected to server
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: info: Volumio Network Manager: Network status updated: 3
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: info: NAA Service Started
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: info: ConvSwitch: Get message: success
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: info: MetaClient: Get message: success
Oct 27 03:07:56 ifi-idsd-phantom sudo[11309]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 1
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 2
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 3
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 4
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.100.107:3000 from 192.168.100.101 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 7
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 8
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: info: Qobuz Connect Service Started
Oct 27 03:07:56 ifi-idsd-phantom volumio[11173]: info: Tidal Connect Service Started
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 9
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 10
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 11
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 12
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 13
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 14
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Reloading queue from file
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getState
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioGetState
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: CorePlayQueue::getTrack 0
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Edg/141.0.0.0 Engine version: 3 Transport: polling Total Clients: 15
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.100.107:3000 from 192.168.100.101 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to 192.168.100.107:3000 from 192.168.100.101 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS testmusic at system boot, trial number 4 ,retrying in 5 seconds
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS testmusic at system boot, trial number 4 ,retrying in 5 seconds
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS testmusic at system boot, trial number 4 ,retrying in 5 seconds
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Asound.conf file unchanged, so no further update is needed
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Tidal connect: Output device has changed
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Output device has changed, restarting MPD
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Qobuz connect: Output device has changed
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Roon Ready: Output device has changed
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Spotify: Output device has changed
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: ___________ START PLUGINS ___________
Oct 27 03:07:57 ifi-idsd-phantom sudo[11459]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service
Oct 27 03:07:57 ifi-idsd-phantom sudo[11459]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: ControllerMpd::onStart: Initializing MPD
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: info: Creating MPD Configuration file
Oct 27 03:07:57 ifi-idsd-phantom sudo[11464]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 27 03:07:57 ifi-idsd-phantom sudo[11464]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:57 ifi-idsd-phantom sudo[11464]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:57 ifi-idsd-phantom play[9162]: 2025-10-27 03:07:57.841 E esdk select error: 4 -> Interrupted system call
Oct 27 03:07:57 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Spotify Connect Service...
Oct 27 03:07:57 ifi-idsd-phantom node[498]: ConvSwitch: Drop client spotify
Oct 27 03:07:57 ifi-idsd-phantom systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM
Oct 27 03:07:57 ifi-idsd-phantom node[513]: Closing connection with the client spotify
Oct 27 03:07:57 ifi-idsd-phantom play[9162]: 2025-10-27 03:07:57.852 I app Exiting with error = 0
Oct 27 03:07:57 ifi-idsd-phantom play[9162]: 2025-10-27 03:07:57.852 I api SpFree()
Oct 27 03:07:57 ifi-idsd-phantom play[9162]: 2025-10-27 03:07:57.853 I api SpFree [returned value: 0]
Oct 27 03:07:57 ifi-idsd-phantom play[9162]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03
Oct 27 03:07:57 ifi-idsd-phantom play[9162]: [Info] ConvSwitch: ConvSwitchInit
Oct 27 03:07:57 ifi-idsd-phantom play[9162]: [Info] MetaClient: MetaClient SDK -- v1.02
Oct 27 03:07:57 ifi-idsd-phantom play[9162]: [Info] MetaClient: MetaClientInit
Oct 27 03:07:57 ifi-idsd-phantom play[9162]: [Info] ConvSwitch: ConvSwitchExit
Oct 27 03:07:57 ifi-idsd-phantom play[9162]: [Info] MetaClient: MetaClientExit
Oct 27 03:07:57 ifi-idsd-phantom systemd[1]: ifi-streamer-spotify-connect.service: Succeeded.
Oct 27 03:07:57 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Spotify Connect Service.
Oct 27 03:07:57 ifi-idsd-phantom systemd[1]: Started iFi Streamer Spotify Connect Service.
Oct 27 03:07:57 ifi-idsd-phantom sudo[11459]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:57 ifi-idsd-phantom volumio[11173]: Starting albumart workers
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: [1761534478044] CoreMusicLibrary::Adding element Media Servers
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 27 03:07:58 ifi-idsd-phantom sudo[11479]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 27 03:07:58 ifi-idsd-phantom sudo[11479]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:58 ifi-idsd-phantom sudo[11479]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:58 ifi-idsd-phantom sudo[11515]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service
Oct 27 03:07:58 ifi-idsd-phantom ethernet-detect[503]: No change in avahi-daemon interfaces. Skipping restart.
Oct 27 03:07:58 ifi-idsd-phantom sudo[11515]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:58 ifi-idsd-phantom systemd[1]: mpd.socket: Succeeded.
Oct 27 03:07:58 ifi-idsd-phantom systemd[1]: Closed mpd.socket.
Oct 27 03:07:58 ifi-idsd-phantom systemd[1]: Stopping Music Player Daemon...
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: output: volumio mixer: hw:0
Oct 27 03:07:58 ifi-idsd-phantom node[498]: ConvSwitch: Add client spotify
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: [1761534478358] CoreMusicLibrary::Adding element Last_100
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: Starting albumart workers
Oct 27 03:07:58 ifi-idsd-phantom systemd[1]: mpd.service: Succeeded.
Oct 27 03:07:58 ifi-idsd-phantom systemd[1]: Stopped Music Player Daemon.
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: Starting RoonReady Sync
Oct 27 03:07:58 ifi-idsd-phantom node[513]: A new connection has been established.
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.447 I api SpRegisterDebugCallbacks [returned value: 0]
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.448 I api SpInit(0xfffe8ce0, API v66)
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.448 I esdk eSDK version: HEAD-v3.166.69-g24821f73
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.448 I esdk Successfully registered socket callbacks: cre, set_opt, cl, bind, list, con, acc, rd, wr, rd_from, wr_to, err, readable, writable, local_addresses, address, pump
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.449 I esdk Successfully registered dns callback: dns_lookup_callback
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.449 I download Using 128 kB for cache buffer
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.449 I download Using 621 kB for compressed audio buffer
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.449 I esdk Successfully registered error callback
Oct 27 03:07:58 ifi-idsd-phantom sudo[11515]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:58 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.001D/input/input29
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: [1761534478461] CoreMusicLibrary::Adding element Webradio
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.481 I esdk Creating IPv4 socket (domain 2)
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.482 I zc webserver: service port 5566 (5566-5576) buffer size 4444
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.482 I zc Started ZeroConf service on port 5566 path /zc alias count 0
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.482 I esdk Creating IPv4 socket (domain 2)
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.482 I api SpInit [returned value: 0]
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.482 I api SpRegisterConnectionCallbacks(0xfffe8cc8, (nil))
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.482 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.483 I api SpRegisterConnectionCallbacks [returned value: 0]
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.483 I api SpRegisterPlaybackCallbacks(0xfffe8cb0, (nil))
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.483 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, -
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.483 I api SpRegisterPlaybackCallbacks [returned value: 0]
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.499 W app Couldn't find mixer for volume controls. (tried , SoftMaster)
Oct 27 03:07:58 ifi-idsd-phantom play[11483]: 2025-10-27 03:07:58.499 I app Initialized!
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 27 03:07:58 ifi-idsd-phantom kernel: hid-generic 0003:20B1:3008.001D: input,hidraw0: USB HID v1.11 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input4
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: Initializing BBC Radios
Oct 27 03:07:58 ifi-idsd-phantom sudo[11568]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service
Oct 27 03:07:58 ifi-idsd-phantom sudo[11568]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom systemd-udevd[11566]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Oct 27 03:07:58 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Roon Ready Service...
Oct 27 03:07:58 ifi-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM
Oct 27 03:07:58 ifi-idsd-phantom node[498]: ConvSwitch: Drop client roon-ready
Oct 27 03:07:58 ifi-idsd-phantom node[513]: Closing connection with the client
Oct 27 03:07:58 ifi-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Succeeded.
Oct 27 03:07:58 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service.
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: Starting albumart workers
Oct 27 03:07:58 ifi-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service.
Oct 27 03:07:58 ifi-idsd-phantom sudo[11568]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:58 ifi-idsd-phantom play[11579]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:58 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 27 03:07:58 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 27 03:07:59 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:07:59 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 27 03:07:59 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:59 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:59 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:59 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:59 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom sudo[11617]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -snf /usr/local/bin/airplay2 /usr/local/bin/shairport-sync
Oct 27 03:07:59 ifi-idsd-phantom sudo[11617]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:07:59 ifi-idsd-phantom sudo[11617]: pam_unix(sudo:session): session closed for user root
Oct 27 03:07:59 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:59 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:07:59 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:07:59 ifi-idsd-phantom volumio[11173]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 27 03:07:59 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:07:59 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 27 03:07:59 ifi-idsd-phantom ifi_metadata[11422]: [Info] MetaClient: MetaClient SDK -- v1.02
Oct 27 03:07:59 ifi-idsd-phantom ifi_metadata[11422]: [Info] MetaClient: MetaClientInit
Oct 27 03:07:59 ifi-idsd-phantom ifi_metadata[11422]: Could not connect: Reason::CONNECTION_ERROR
Oct 27 03:07:59 ifi-idsd-phantom volumio[11173]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 27 03:07:59 ifi-idsd-phantom node[498]: ConvSwitch: Add client roon-ready
Oct 27 03:07:59 ifi-idsd-phantom volumio[11173]: info: Volumio Calling Home
Oct 27 03:07:59 ifi-idsd-phantom node[498]: ConvSwitch: Add client tidal
Oct 27 03:07:59 ifi-idsd-phantom tidal_connect_application[11641]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi.
Oct 27 03:07:59 ifi-idsd-phantom tidal_connect_application[11641]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 27 03:07:59 ifi-idsd-phantom tidal_connect_application[11641]: *** WARNING *** For more information see 
Oct 27 03:07:59 ifi-idsd-phantom ifi_metadata[11422]: Connected
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setRepeat null single undefined
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::pushState
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CorePlayQueue::getTrack 0
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioPushState
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setRandom null
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::pushState
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CorePlayQueue::getTrack 0
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioPushState
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: Discovery: adding 9646465e-97bc-43db-8925-ba167a8e6eb5
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: Discovery: Found device iDSD PHANTOM-2-2
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: Discovery: Connecting to remote: 192.168.100.101
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getQueue
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioGetQueue
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::getQueue
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CorePlayQueue::getQueue
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getDeviceHWUUID
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ callMethod: {"endpoint":"music_service/inputs","method":"serialMonitorAction","data":{"action":"get"}}
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object]
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ callMethod: {"endpoint":"system_controller/motivocontrol","method":"displaySelection","data":{"action":"get"}}
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object]
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: error: Could not retrieve plugin system_controller motivocontrol
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getMultiRoomDevices: null
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: Starting RoonReady Sync
Oct 27 03:08:00 ifi-idsd-phantom sudo[11697]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service
Oct 27 03:08:00 ifi-idsd-phantom sudo[11697]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:00 ifi-idsd-phantom sudo[11707]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service
Oct 27 03:08:00 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Qobuz Connect Service...
Oct 27 03:08:00 ifi-idsd-phantom sudo[11707]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:00 ifi-idsd-phantom node[498]: ConvSwitch: Drop client qobuz-connect
Oct 27 03:08:00 ifi-idsd-phantom node[513]: Closing connection with the client qobuz-connect
Oct 27 03:08:00 ifi-idsd-phantom systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM
Oct 27 03:08:00 ifi-idsd-phantom systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded.
Oct 27 03:08:00 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Qobuz Connect Service.
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getMultiroom: null
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: error: Could not retrieve plugin audio_interface multiroom
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getState
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioGetState
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CorePlayQueue::getTrack 0
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getBrowseSources: null
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 27 03:08:00 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Roon Ready Service...
Oct 27 03:08:00 ifi-idsd-phantom node[498]: ConvSwitch: Drop client roon-ready
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 27 03:08:00 ifi-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM
Oct 27 03:08:00 ifi-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Succeeded.
Oct 27 03:08:00 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service.
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getMenuItems
Oct 27 03:08:00 ifi-idsd-phantom sudo[11697]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:00 ifi-idsd-phantom sudo[11711]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getMenuItems
Oct 27 03:08:00 ifi-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service.
Oct 27 03:08:00 ifi-idsd-phantom sudo[11711]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:00 ifi-idsd-phantom sudo[11707]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getQueue
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioGetQueue
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::getQueue
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CorePlayQueue::getQueue
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ listPlaylist: null
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: Listing playlists
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getMenuItems
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getMenuItems
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getMenuItems
Oct 27 03:08:00 ifi-idsd-phantom play[11712]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getMenuItems
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: ConvSwitch: Get message: request:pause
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioStop
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::stop
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioStop
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::stop
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:08:00 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:08:01 ifi-idsd-phantom sudo[11711]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: ++++--++++ initSocket: {"id":"9646465e-97bc-43db-8925-ba167a8e6eb5"}
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: Airplay2 Started
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: error: Could not retrieve plugin music_service airplay1_switch
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: Disabling plugin airplay1_switch
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: Done.
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: RoonReady Started
Oct 27 03:08:01 ifi-idsd-phantom sudo[11738]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync
Oct 27 03:08:01 ifi-idsd-phantom sudo[11738]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: MPD Permissions set
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: MPD Permissions set
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: Spotify Connect Service Started
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 27 03:08:01 ifi-idsd-phantom sudo[11752]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service
Oct 27 03:08:01 ifi-idsd-phantom sudo[11752]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: Discovery: adding a21ccbf7-45d7-4ee8-a690-65c336ecf53c
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: Discovery: Found device ZEN Stream
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: shairport-sync.service: Succeeded.
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: Discovery: Connecting to remote: 192.168.1.141
Oct 27 03:08:01 ifi-idsd-phantom sudo[11738]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Listening on mpd.socket.
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info:
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: ---------------------------- Client requests Start RoonReady PlaybackRoutine
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Starting Music Player Daemon...
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: Roon Ready playback start
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioStop
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::stop
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: Starting Roon Ready metadata receiver
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: Error adding Membership: Error: addMembership EINVAL
Oct 27 03:08:01 ifi-idsd-phantom node[498]: ConvSwitch: Add client roon-ready
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: RoonReady Started
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: Volumio called home
Oct 27 03:08:01 ifi-idsd-phantom sudo[11777]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service
Oct 27 03:08:01 ifi-idsd-phantom sudo[11777]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:01 ifi-idsd-phantom sudo[11762]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Oct 27 03:08:01 ifi-idsd-phantom sudo[11762]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:01 ifi-idsd-phantom sudo[11762]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: mpd.socket: Succeeded.
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Closed mpd.socket.
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Stopping mpd.socket.
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: mpd.socket: Socket service mpd.service already active, refusing.
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Failed to listen on mpd.socket.
Oct 27 03:08:01 ifi-idsd-phantom sudo[11784]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service
Oct 27 03:08:01 ifi-idsd-phantom sudo[11784]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: mpd.service: Succeeded.
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Stopped Music Player Daemon.
Oct 27 03:08:01 ifi-idsd-phantom node[513]: Closing connection with the client tidal-connect
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Tidal Metadata Service...
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Listening on mpd.socket.
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Starting Music Player Daemon...
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded.
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Tidal Metadata Service.
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Tidal Connect Service...
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: ifi-streamer-tidal-connect.service: Succeeded.
Oct 27 03:08:01 ifi-idsd-phantom node[498]: ConvSwitch: Drop client tidal
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Tidal Connect Service.
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Started iFi Streamer Tidal Connect Service.
Oct 27 03:08:01 ifi-idsd-phantom systemd[1]: Started iFi Streamer Tidal Metadata Service.
Oct 27 03:08:01 ifi-idsd-phantom node[513]: A new connection has been established.
Oct 27 03:08:01 ifi-idsd-phantom sudo[11784]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: error: Could not retrieve plugin audio_interface multiroom
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: Discovery: Connected to remote: 192.168.100.101
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: error: Could not retrieve plugin audio_interface multiroom
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: ConvSwitch: Get message: request:pause
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioStop
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::stop
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioStop
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::stop
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 18
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: Shairport-Sync Stopped
Oct 27 03:08:01 ifi-idsd-phantom sudo[11789]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Oct 27 03:08:01 ifi-idsd-phantom sudo[11789]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:01 ifi-idsd-phantom sudo[11789]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 27 03:08:01 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getState
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioGetState
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CorePlayQueue::getTrack 0
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: Tidal Connect Service Started
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info:
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: ---------------------------- Client requests Start RoonReady PlaybackRoutine
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: Roon Ready playback start
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioStop
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::stop
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: Roon Ready metadata receiver is on
Oct 27 03:08:02 ifi-idsd-phantom sudo[11835]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service
Oct 27 03:08:02 ifi-idsd-phantom sudo[11835]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: Discovery: adding 52b739d8-1fcd-40df-a336-b77b431ac5de
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: Discovery: Found device iDSD PHANTOM
Oct 27 03:08:02 ifi-idsd-phantom sudo[11837]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioGetState
Oct 27 03:08:02 ifi-idsd-phantom sudo[11837]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:02 ifi-idsd-phantom volumio[11173]: error: Could not retrieve plugin audio_interface multiroom
Oct 27 03:08:02 ifi-idsd-phantom sudo[11837]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:02 ifi-idsd-phantom systemd[1]: Started iFi Streamer Qobuz Connect Service.
Oct 27 03:08:02 ifi-idsd-phantom sudo[11835]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:02 ifi-idsd-phantom sudo[11840]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 27 03:08:02 ifi-idsd-phantom sudo[11840]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:02 ifi-idsd-phantom sudo[11840]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:02 ifi-idsd-phantom play[11843]: 20251027 03:08:02.999 [11861.11861] DEBUG SampleApp: Starting sample application
Oct 27 03:08:02 ifi-idsd-phantom play[11843]: 20251027 03:08:02.999 [11861.11861] DEBUG SampleApp:     Device Name: iDSD PHANTOM
Oct 27 03:08:02 ifi-idsd-phantom play[11843]: 20251027 03:08:02.999 [11861.11861] DEBUG SampleApp:     Manufacturer: Sample manufacturer
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:02.999 [11861.11861] DEBUG SampleApp:     Model: iFi Streamer
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:02.999 [11861.11861] DEBUG SampleApp:     Serial Number: ifi:0a:3f:b4:ff:19:14
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:02.999 [11861.11861] DEBUG SampleApp:     Audio output device: volumio
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.000 [11861.11861] DEBUG SampleApp:     Volume control device: default
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.000 [11861.11861] DEBUG SampleApp:     Volume control element: Master
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.000 [11861.11861] DEBUG SampleApp:     Local config server port: 8000
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.009 [11861.11861] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.009 [11861.11861] DEBUG SampleApp:     Maximum supported audio quality: HIRES_L3
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: [Info] MetaClient: MetaClient SDK -- v1.02
Oct 27 03:08:03 ifi-idsd-phantom node[513]: A new connection has been established.
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 27 03:08:03 ifi-idsd-phantom node[513]: A new connection has been established.
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Starting Shairport Sync
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: [Info] MetaClient: MetaClientInit
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03
Oct 27 03:08:03 ifi-idsd-phantom node[498]: ConvSwitch: Add client qobuz-connect
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Starting Shairport Sync
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: [Info] ConvSwitch: ConvSwitchInit
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.123 [11861.11861] DEBUG ActiveStateManager: [0xab41c978]: Creating new Active State Manager
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.123 [11861.11861] DEBUG NetworkActivityTracker: [0xab41c9e8]: Creating new Network Activity Tracker
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.124 [11861.11861] DEBUG EndpointManager: [0xab41d960]: Creating Endpoint Manager
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.124 [11861.11861] DEBUG PlaybackSessionManager: [0xab41dd50]: Creating Playback Session Manager
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.124 [11861.11861] DEBUG BackoffTimer: [0xab41dec8]: Creating Backoff Timer
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.124 [11861.11861] DEBUG MediaEngine: [0xab41dfe8]: Creating new Media Engine
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.124 [11861.11861] DEBUG AudioRenderer: [0xab41e208]: Creating Audio Renderer
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.124 [11861.11861] TRACE MediaEngineCommandSequencer: [0xab41e360]: Creating Media Engine Command Sequencer
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.124 [11861.11861] DEBUG PlaybackControlsManager: [0xab41e3c0]: Creating new Playback Controls Manager
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] DEBUG VolumeManager: [0xab41e450]: Creating new Volume Manager
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] DEBUG ProtocolHandler: [0xab41e728]: Creating Protocol Handler
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] DEBUG MessageReceiver: [0xab41e7c8]: Creating Message Receiver
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] DEBUG RendererActivationController: [0xab41e940]: Creating new Renderer Activation Controller
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] TRACE RendererActivationCommandSequencer: [0xab41e9e8]: Creating Renderer Activation Command Sequencer
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] DEBUG ReportingManager: [0xab41eaf8]: Creating new Reporting Manager
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] DEBUG StreamingEventReporter: [0xab41eb40]: Creating Streaming Event Reporter
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] DEBUG BackoffTimer: [0xab41ec20]: Creating Backoff Timer
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] DEBUG TokenExpiryController: [0xab41ed30]: Creating Token Expiry Controller
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] DEBUG UserInactivityManager: [0xab41ed80]: Creating new User Inactivity Manager
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] INFO VolumeManager: [0xab41e450]: Setting new playback volume: 100
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] INFO VolumeManager: [0xab41e450]: Setting new mute state: 1
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] DEBUG SampleApp: Qobuz Connect has been initialized
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] TRACE SampleApp: Running event loop
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] INFO QobuzConnect: [0xab41ee20]: Client initialized!
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.125 [11861.11861] INFO SampleApp: Starting Avahi advertising, name: iDSD PHANTOM, service name: _qobuz-connect._tcp
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.144 [11861.11861] DEBUG SampleApp: Avahi client state changed: RUNNING
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Discovery: this is already registered,  52b739d8-1fcd-40df-a336-b77b431ac5de
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.153 [11861.11861] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.162 [11861.11861] INFO LocalConfigManager: [0xab41dd30]: Starting Local Configuration server
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.162 [11861.11861] INFO SampleApp: Starting Local configuration server
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.163 [11861.11861] INFO SampleApp: Playback mute state changed: 1
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.164 [11861.11861] ERROR SampleApp: Unable to set mute state, no ALSA volume element
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.164 [11861.11861] DEBUG SampleApp: Avahi entry group state changed: REGISTERING
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.164 [11861.11861] INFO SampleApp: Playback volume changed: 100
Oct 27 03:08:03 ifi-idsd-phantom play[11843]: 20251027 03:08:03.164 [11861.11861] ERROR SampleApp: Unable to set volume, no ALSA volume element
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Discovery: Found device iDSD PHANTOM
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioGetState
Oct 27 03:08:03 ifi-idsd-phantom sudo[11867]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 27 03:08:03 ifi-idsd-phantom sudo[11867]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: error: Could not retrieve plugin audio_interface multiroom
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 27 03:08:03 ifi-idsd-phantom sudo[11867]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:03 ifi-idsd-phantom sudo[11870]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 27 03:08:03 ifi-idsd-phantom sudo[11870]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: shairport-sync.service: Succeeded.
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 27 03:08:03 ifi-idsd-phantom sudo[11870]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: ++++--++++ getState
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioGetState
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Qobuz Connect Service Started
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Shairport-Sync Started
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: Error adding Membership: Error: addMembership EINVAL
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Shairport-Sync Started
Oct 27 03:08:03 ifi-idsd-phantom sudo[11890]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service
Oct 27 03:08:03 ifi-idsd-phantom sudo[11890]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:03 ifi-idsd-phantom play[11483]: 2025-10-27 03:08:03.761 E esdk select error: 4 -> Interrupted system call
Oct 27 03:08:03 ifi-idsd-phantom play[11483]: 2025-10-27 03:08:03.763 I app Exiting with error = 0
Oct 27 03:08:03 ifi-idsd-phantom play[11483]: 2025-10-27 03:08:03.763 I api SpFree()
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Spotify Connect Service...
Oct 27 03:08:03 ifi-idsd-phantom node[513]: Closing connection with the client spotify
Oct 27 03:08:03 ifi-idsd-phantom play[11483]: 2025-10-27 03:08:03.776 I api SpFree [returned value: 0]
Oct 27 03:08:03 ifi-idsd-phantom play[11483]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03
Oct 27 03:08:03 ifi-idsd-phantom play[11483]: [Info] ConvSwitch: ConvSwitchInit
Oct 27 03:08:03 ifi-idsd-phantom play[11483]: [Info] MetaClient: MetaClient SDK -- v1.02
Oct 27 03:08:03 ifi-idsd-phantom play[11483]: [Info] MetaClient: MetaClientInit
Oct 27 03:08:03 ifi-idsd-phantom play[11483]: [Info] ConvSwitch: ConvSwitchExit
Oct 27 03:08:03 ifi-idsd-phantom play[11483]: [Info] MetaClient: MetaClientExit
Oct 27 03:08:03 ifi-idsd-phantom node[498]: ConvSwitch: Drop client spotify
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: ifi-streamer-spotify-connect.service: Succeeded.
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Spotify Connect Service.
Oct 27 03:08:03 ifi-idsd-phantom sudo[11893]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart upmpdcli.service
Oct 27 03:08:03 ifi-idsd-phantom sudo[11893]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: Started iFi Streamer Spotify Connect Service.
Oct 27 03:08:03 ifi-idsd-phantom sudo[11890]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: Stopping UPnP Renderer front-end to MPD...
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: upmpdcli.service: Succeeded.
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: Stopped UPnP Renderer front-end to MPD.
Oct 27 03:08:03 ifi-idsd-phantom volumio[11173]: info: Spotify Connect Service Started
Oct 27 03:08:03 ifi-idsd-phantom systemd[1]: Starting UPnP Renderer front-end to MPD...
Oct 27 03:08:03 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:08:03 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:08:03 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:03 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:08:04 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.001E/input/input30
Oct 27 03:08:04 ifi-idsd-phantom play[11843]: 20251027 03:08:04.035 [11861.11861] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: output: volumio mixer: hw:0
Oct 27 03:08:04 ifi-idsd-phantom kernel: hid-generic 0003:20B1:3008.001E: input,hidraw0: USB HID v1.11 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input4
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom node[498]: ConvSwitch: Add client spotify
Oct 27 03:08:04 ifi-idsd-phantom node[513]: A new connection has been established.
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom systemd-udevd[11921]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.213 I api SpRegisterDebugCallbacks [returned value: 0]
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.213 I api SpInit(0xffbaf620, API v66)
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.213 I esdk eSDK version: HEAD-v3.166.69-g24821f73
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.214 I esdk Successfully registered socket callbacks: cre, set_opt, cl, bind, list, con, acc, rd, wr, rd_from, wr_to, err, readable, writable, local_addresses, address, pump
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.214 I esdk Successfully registered dns callback: dns_lookup_callback
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.214 I download Using 128 kB for cache buffer
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.214 I download Using 621 kB for compressed audio buffer
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.214 I esdk Successfully registered error callback
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.241 I esdk Creating IPv4 socket (domain 2)
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.241 I zc webserver: service port 5566 (5566-5576) buffer size 4444
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.242 I zc Started ZeroConf service on port 5566 path /zc alias count 0
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.242 I esdk Creating IPv4 socket (domain 2)
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.242 I api SpInit [returned value: 0]
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.242 I api SpRegisterConnectionCallbacks(0xffbaf608, (nil))
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.242 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.242 I api SpRegisterConnectionCallbacks [returned value: 0]
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.242 I api SpRegisterPlaybackCallbacks(0xffbaf5f0, (nil))
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.242 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, -
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.242 I api SpRegisterPlaybackCallbacks [returned value: 0]
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.259 W app Couldn't find mixer for volume controls. (tried , SoftMaster)
Oct 27 03:08:04 ifi-idsd-phantom play[11894]: 2025-10-27 03:08:04.260 I app Initialized!
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Oct 27 03:08:04 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Oct 27 03:08:04 ifi-idsd-phantom ifi_metadata[11791]: [Info] MetaClient: MetaClient SDK -- v1.02
Oct 27 03:08:04 ifi-idsd-phantom ifi_metadata[11791]: [Info] MetaClient: MetaClientInit
Oct 27 03:08:04 ifi-idsd-phantom ifi_metadata[11791]: Could not connect: Reason::CONNECTION_ERROR
Oct 27 03:08:05 ifi-idsd-phantom node[498]: ConvSwitch: Add client tidal
Oct 27 03:08:05 ifi-idsd-phantom tidal_connect_application[11952]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi.
Oct 27 03:08:05 ifi-idsd-phantom tidal_connect_application[11952]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 27 03:08:05 ifi-idsd-phantom tidal_connect_application[11952]: *** WARNING *** For more information see 
Oct 27 03:08:05 ifi-idsd-phantom ifi_metadata[11791]: Connected
Oct 27 03:08:05 ifi-idsd-phantom volumio[11173]: error: Could not retrieve plugin audio_interface multiroom
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: ++++--++++ playItemsList: {"item":{"service":"mpd","type":"song","title":"(DSD64)Divertimento DSD.dff","artist":"","album":"","uri":"music-library/NAS/testmusic/(DSD64)Divertimento DSD.dff","albumart":"/albumart?cacheid=868_1761534249908&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},"list":[{"service":"mpd","type":"song","title":"352kHz Divertimento 352.8-24","artist":"","album":"","uri":"music-library/NAS/testmusic/(352kHz)Divertimento 352.8-24.flac","albumart":"/albumart?cacheid=868_1761534249907&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"768kHz Jheena Lodwick - Perhaps Love","artist":"","album":"","uri":"music-library/NAS/testmusic/(768kHz)Jheena Lodwick - Perhaps Love.wav","albumart":"/albumart?cacheid=868_1761534249908&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"(DSD128)Divertimento DSD128.dff","artist":"","album":"","uri":"music-library/NAS/testmusic/(DSD128)Divertimento DSD128.dff","albumart":"/albumart?cacheid=868_1761534249908&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"(DSD256)k4.dff","artist":"","album":"","uri":"music-library/NAS/testmusic/(DSD256)k4.dff","albumart":"/albumart?cacheid=868_1761534249908&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"(DSD512)o5.dff","artist":"","album":"","uri":"music-library/NAS/testmusic/(DSD512)o5.dff","albumart":"/albumart?cacheid=868_1761534249908&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"(DSD64)Divertimento DSD.dff","artist":"","album":"","uri":"music-library/NAS/testmusic/(DSD64)Divertimento DSD.dff","albumart":"/albumart?cacheid=868_1761534249908&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac","artist":"","album":"","uri":"music-library/NAS/testmusic/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac","albumart":"/albumart?cacheid=868_1761534249909&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"2966923830.mp3","artist":"","album":"","uri":"music-library/NAS/testmusic/2966923830.mp3","albumart":"/albumart?cacheid=868_1761534249909&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"DSD1024 ゆらめき(Waver) .dff","artist":"","album":"","uri":"music-library/NAS/testmusic/DSD1024 ゆらめき(Waver) .dff","albumart":"/albumart?cacheid=868_1761534249909&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"freeloop.mp3","artist":"","album":"","uri":"music-library/NAS/testmusic/freeloop.mp3","albumart":"/albumart?cacheid=868_1761534249909&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"44 PCM 44.4k(左声道)单身情歌--(右声道)单眼皮女生","artist":"","album":"","uri":"music-library/NAS/testmusic/PCM 44.4k(左声道)单身情歌---(右声道)单眼皮女生.flac","albumart":"/albumart?cacheid=868_1761534249909&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"사랑 하나면돼.mp3","artist":"","album":"","uri":"music-library/NAS/testmusic/사랑 하나면돼.mp3","albumart":"/albumart?cacheid=868_1761534249909&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"사랑이 그렇게 쉬워.mp3","artist":"","album":"","uri":"music-library/NAS/testmusic/사랑이 그렇게 쉬워.mp3","albumart":"/albumart?cacheid=868_1761534249909&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"うっせぇわ.mp3","artist":"","album":"","uri":"music-library/NAS/testmusic/うっせぇわ.mp3","albumart":"/albumart?cacheid=868_1761534249909&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"ドライフラワー.mp3","artist":"","album":"","uri":"music-library/NAS/testmusic/ドライフラワー.mp3","albumart":"/albumart?cacheid=868_1761534249909&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"һ??????","artist":"ˮľ?껪","album":"","uri":"music-library/NAS/testmusic/一生有你-水木年华-323044.mp3","albumart":"/albumart?cacheid=868_1761534249909&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"光輝歲月.mp3","artist":"","album":"","uri":"music-library/NAS/testmusic/光輝歲月.mp3","albumart":"/albumart?cacheid=868_1761534249910&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"歌曲(左声道)单身情歌---(右声道)单眼皮女生.dff","artist":"","album":"","uri":"music-library/NAS/testmusic/歌曲(左声道)单身情歌---(右声道)单眼皮女生.dff","albumart":"/albumart?cacheid=868_1761534249910&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"海闊天空.mp3","artist":"","album":"","uri":"music-library/NAS/testmusic/海闊天空.mp3","albumart":"/albumart?cacheid=868_1761534249910&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"灰色軌跡.mp3","artist":"","album":"","uri":"music-library/NAS/testmusic/灰色軌跡.mp3","albumart":"/albumart?cacheid=868_1761534249910&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"???Ƶ?","artist":"??????","album":"","uri":"music-library/NAS/testmusic/電燈膽.mp3","albumart":"/albumart?cacheid=868_1761534249910&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"384_03 - Divertimento 384","artist":"","album":"","uri":"music-library/NAS/testmusic/(384kHz)Divertimento 382.flac","albumart":"/albumart?cacheid=868_1761534249910&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Original Rate 44100 24bit.green.mqa","artist":"MQA Ltd","album":"000 UI","uri":"music-library/NAS/testmusic/002 Original Rate 44100 24bit.green.mqa.flac","albumart":"/albumart?cacheid=868_1761534249910&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Original Rate 44100 24bit.blue.mqa","artist":"MQA Ltd","album":"000 UI","uri":"music-library/NAS/testmusic/009 Original Rate 44100 24bit.blue.mqa.Studio.flac","albumart":"/albumart?cacheid=868_1761534249910&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"OFS","artist":"MQA Ltd","album":"000 UI","uri":"music-library/NAS/testmusic/029 Original Rate 44100 24bit OFS.flac","albumart":"/albumart?cacheid=868_1761534249910&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"192kHz Divertimento 192-24","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/NAS/testmusic/(192kHz)Divertimento 192-24.flac","albumart":"/albumart?cacheid=868_1761534249910&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"48 Simple Symphony  op. 4 - Boisterous Bourree 48kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/NAS/testmusic/(48kHz)Divertimento 48-24.flac","albumart":"/albumart?cacheid=868_1761534249911&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"88 Simple Symphony  op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/NAS/testmusic/(88kHz)Divertimento 88-24.flac","albumart":"/albumart?cacheid=868_1761534249911&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"96 Simple Symphony  op. 4 - Boisterous Bourree 96kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/NAS/testmusic/(96kHz)Divertimento 96-24.flac","albumart":"/albumart?cacheid=868_1761534249911&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Ò£Ô¶µÄËý(ÏÖ³¡°æ)+-+Eason+&+Fri","artist":"³ÂÞÈѸ","album":"Eason And Friends 903 Id Club","uri":"music-library/NAS/testmusic/遥远的她-陈奕迅-76552.mp3","albumart":"/albumart?cacheid=868_1761534249911&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Hopak [TCHAIKOVSKY: Mazeppa] 176kHz","artist":"Minnesota Orchestra, Eiji Oue","album":"Exotic Dances From The Opera","uri":"music-library/NAS/testmusic/(176kHz)Tchaikovsky Hopak 176-24.flac","albumart":"/albumart?cacheid=868_1761534249912&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Carmen 44kHz","artist":"Carmen","album":"RMAF 2010","uri":"music-library/NAS/testmusic/(44kHz)Carmen 44.flac","albumart":"/albumart?cacheid=868_1761534249912&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"±´¼Ó¶ûºþÅÏ","artist":"À","album":"依然","uri":"music-library/NAS/testmusic/贝加尔湖畔-《无心法师》电视剧片头曲-李健-1116274.mp3","albumart":"/albumart?cacheid=868_1761534249912&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"我好像在哪见过你-《精灵王座》动画电影主题曲","artist":"薛之谦","album":"初学者","uri":"music-library/NAS/testmusic/我好像在哪见过你-《精灵王座》动画电影主题曲-薛之谦-7201115.mp3","albumart":"/albumart?cacheid=868_1761534249912&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"国王与乞丐","artist":"杨宗纬&华晨宇","album":"地球之盐","uri":"music-library/NAS/testmusic/国王与乞丐-杨宗纬_华晨宇-143903654.mp3","albumart":"/albumart?cacheid=868_1761534249912&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"夜に駆ける","artist":"YOASOBI","album":"夜に駆ける","uri":"music-library/NAS/testmusic/夜に駆ける.mp3","albumart":"/albumart?cacheid=868_1761534249912&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"银の龙の背に秉って","artist":"中島みゆき","album":"恋文","uri":"music-library/NAS/testmusic/3040479752.mp3","albumart":"/albumart?cacheid=868_1761534249912&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"说谎","artist":"林宥嘉","album":"湘江音乐节","uri":"music-library/NAS/testmusic/说谎-林宥嘉-23543156.mp3","albumart":"/albumart?cacheid=868_1761534249912&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"说谎","artist":"林宥嘉","album":"湘江音乐节","uri":"music-library/NAS/testmusic/说谎-林宥嘉-23543156(1).mp3","albumart":"/albumart?cacheid=868_1761534249912&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"平凡之路 (电影《后会无期》主题曲)","artist":"朴树","album":"猎户星座","uri":"music-library/NAS/testmusic/平凡之路_(电影《后会无期》主题曲)-朴树-5960811.mp3","albumart":"/albumart?cacheid=868_1761534249913&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"我记得","artist":"赵雷","album":"署前街少年","uri":"music-library/NAS/testmusic/我记得.mp3","albumart":"/albumart?cacheid=868_1761534249913&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"南方姑娘-《米花之味》电影推广曲","artist":"赵雷","album":"赵小雷","uri":"music-library/NAS/testmusic/南方姑娘-《米花之味》电影推广曲-赵雷-2134876.mp3","albumart":"/albumart?cacheid=868_1761534249913&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Ê®Äê","artist":"³ÂÞÈѸ","album":"黑白灰","uri":"music-library/NAS/testmusic/十年-陈奕迅-80403.mp3","albumart":"/albumart?cacheid=868_1761534249913&path=%2Fmnt%2FNAS%2Ftestmusic&icon=music&metadata=false"}],"index":5}
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: Preload queue cleared
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::ClearQueue
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::stop
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::serviceStop
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::serviceStop
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioStop
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::stop
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: Roon Ready Stop
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CorePlayQueue::clearPlayQueue
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CorePlayQueue::saveQueue
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CoreCommandRouter::volumioPushQueue
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CoreStateMachine::addQueueItems
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: CorePlayQueue::addQueueItems
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: Preload queue cleared
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: Adding Item to queue: music-library/NAS/testmusic/(352kHz)Divertimento 352.8-24.flac
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: info: Exploding uri music-library/NAS/testmusic/(352kHz)Divertimento 352.8-24.flac in service mpd
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: TypeError: Cannot read property 'then' of undefined
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2878:19)
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2676:21)
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1528:16)
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24)
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19)
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30)
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:252:25)
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:628:25)
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at CoreCommandRouter.playItemsList (/volumio/app/index.js:600:19)
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:156:33)
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at Socket.emit (events.js:400:28)
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at /volumio/node_modules/socket.io/lib/socket.js:528:12
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]:     at processTicksAndRejections (internal/process/task_queues.js:77:11)
Oct 27 03:08:06 ifi-idsd-phantom volumio[11173]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 27 03:08:06 ifi-idsd-phantom mpd[11801]: Oct 27 03:08 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Oct 27 03:08:06 ifi-idsd-phantom systemd[1]: Started Music Player Daemon.
Oct 27 03:08:06 ifi-idsd-phantom sudo[11752]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:06 ifi-idsd-phantom sudo[11777]: pam_unix(sudo:session): session closed for user root
Oct 27 03:08:07 ifi-idsd-phantom sudo[12013]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-27 03:07
Oct 27 03:08:07 ifi-idsd-phantom sudo[12013]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="b6b5fc9c726190e478d1307bf4816c8d6dfb5af2"
VOLUMIO_FE_VERSION="607f0b2839009ad71a89496f82d0c60770a281b7"
VOLUMIO_FE3_VERSION="c98f50471352dc221c4a2aa0af52effb0ef3ca54"
VOLUMIO_BE_VERSION="f5b63c76b11d74c933cf85f8a1184b66a9fb4841"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="ifi"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon Oct 27 09:11:36 CST 2025"
VOLUMIO_VERSION="2.02.0"
VOLUMIO_HARDWARE="idsd-phantom"
VOLUMIO_DEVICENAME="iDSD PHANTOM"
VOLUMIO_HASH="67c00802f01b9142598057c28b7134d9"