Jan 27 17:37:02 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:37:02 volumio volumio[1178]: info: Listing playlists Jan 27 17:37:02 volumio volumio[1178]: info: Listing playlists Jan 27 17:37:03 volumio avahi-daemon[1246]: Record [04255CB411F0\064Volumio._raop._tcp.local IN TXT "sf=0x4" "fv=76400.10" "am=ShairportSync" "vs=105.1" "tp=TCP,UDP" "vn=65537" "md=0,2" "ss=16" "sr=44100" "da=true" "sv=false" "et=0,1" "ek=1" "cn=0,1" "ch=2" "txtvers=1" "pw=false" ; ttl=4500] not fi Jan 27 17:37:03 volumio avahi-daemon[1246]: Record [Volumio._qobuz-connect._tcp.local IN TXT "path=/" "device_uuid=4c9e9b96-0977-5c47-b912-04e9f36d58f0" "sdk_version=1.0.0-b681" "type=STREAMER" ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:37:03 volumio avahi-daemon[1246]: Record [volumio._Volumio._tcp.local IN TXT "volumioName=Volumio" "UUID=01168f73-f41d-4cf5-9cb2-1af1924d8e78" ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:37:03 volumio avahi-daemon[1246]: Record [VOLUMIO._device-info._tcp.local IN TXT "model=AirPort" ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:37:03 volumio avahi-daemon[1246]: Record [VOLUMIO._device-info._tcp.local IN SRV 0 0 0 volumio.local ; ttl=120] not fitting in legacy unicast packet, dropping. Jan 27 17:37:03 volumio avahi-daemon[1246]: Record [_smb._tcp.local IN PTR VOLUMIO._smb._tcp.local ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:37:03 volumio avahi-daemon[1246]: Record [VOLUMIO._smb._tcp.local IN TXT ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:37:03 volumio avahi-daemon[1246]: Record [VOLUMIO._smb._tcp.local IN SRV 0 0 445 volumio.local ; ttl=120] not fitting in legacy unicast packet, dropping. Jan 27 17:37:03 volumio avahi-daemon[1246]: Record [_smb._tcp.local IN PTR VOLUMIO._smb._tcp.local ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:37:03 volumio avahi-daemon[1246]: Record [VOLUMIO._smb._tcp.local IN TXT ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:37:03 volumio avahi-daemon[1246]: Record [VOLUMIO._smb._tcp.local IN SRV 0 0 445 volumio.local ; ttl=120] not fitting in legacy unicast packet, dropping. Jan 27 17:37:12 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:37:22 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:37:22 volumio volumio[1178]: info: Listing playlists Jan 27 17:37:22 volumio volumio[1178]: info: Listing playlists Jan 27 17:37:32 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:37:42 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:37:42 volumio volumio[1178]: info: Listing playlists Jan 27 17:37:42 volumio volumio[1178]: info: Listing playlists Jan 27 17:37:52 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:02 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:02 volumio volumio[1178]: info: Listing playlists Jan 27 17:38:02 volumio volumio[1178]: info: Listing playlists Jan 27 17:38:12 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:15 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 27 17:38:15 volumio volumio[1178]: info: Received Get System Info Jan 27 17:38:15 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 27 17:38:15 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 27 17:38:15 volumio volumio[1178]: info: Discovery: Getting this device information Jan 27 17:38:15 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:15 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 27 17:38:22 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:22 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:22 volumio volumio[1178]: info: Listing playlists Jan 27 17:38:22 volumio volumio[1178]: info: Listing playlists Jan 27 17:38:24 volumio volumio[1178]: info: Executing endpoint metavolumio Jan 27 17:38:24 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 27 17:38:24 volumio volumio[1178]: info: Executing endpoint metavolumio Jan 27 17:38:24 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 27 17:38:24 volumio volumio[1178]: info: Executing endpoint metavolumio Jan 27 17:38:24 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 27 17:38:26 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 27 17:38:26 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 27 17:38:32 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:33 volumio avahi-daemon[1246]: Record [04255CB411F0\064Volumio._raop._tcp.local IN TXT "sf=0x4" "fv=76400.10" "am=ShairportSync" "vs=105.1" "tp=TCP,UDP" "vn=65537" "md=0,2" "ss=16" "sr=44100" "da=true" "sv=false" "et=0,1" "ek=1" "cn=0,1" "ch=2" "txtvers=1" "pw=false" ; ttl=4500] not fi Jan 27 17:38:33 volumio avahi-daemon[1246]: Record [Volumio._qobuz-connect._tcp.local IN TXT "path=/" "device_uuid=4c9e9b96-0977-5c47-b912-04e9f36d58f0" "sdk_version=1.0.0-b681" "type=STREAMER" ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:38:33 volumio avahi-daemon[1246]: Record [volumio._Volumio._tcp.local IN TXT "volumioName=Volumio" "UUID=01168f73-f41d-4cf5-9cb2-1af1924d8e78" ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:38:33 volumio avahi-daemon[1246]: Record [VOLUMIO._device-info._tcp.local IN TXT "model=AirPort" ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:38:33 volumio avahi-daemon[1246]: Record [VOLUMIO._device-info._tcp.local IN SRV 0 0 0 volumio.local ; ttl=120] not fitting in legacy unicast packet, dropping. Jan 27 17:38:33 volumio avahi-daemon[1246]: Record [_smb._tcp.local IN PTR VOLUMIO._smb._tcp.local ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:38:33 volumio avahi-daemon[1246]: Record [VOLUMIO._smb._tcp.local IN TXT ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:38:33 volumio avahi-daemon[1246]: Record [VOLUMIO._smb._tcp.local IN SRV 0 0 445 volumio.local ; ttl=120] not fitting in legacy unicast packet, dropping. Jan 27 17:38:33 volumio avahi-daemon[1246]: Record [_smb._tcp.local IN PTR VOLUMIO._smb._tcp.local ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:38:33 volumio avahi-daemon[1246]: Record [VOLUMIO._smb._tcp.local IN TXT ; ttl=4500] not fitting in legacy unicast packet, dropping. Jan 27 17:38:33 volumio avahi-daemon[1246]: Record [VOLUMIO._smb._tcp.local IN SRV 0 0 445 volumio.local ; ttl=120] not fitting in legacy unicast packet, dropping. Jan 27 17:38:34 volumio volumio[1178]: info: CorePlayQueue::getTrack 4 Jan 27 17:38:34 volumio volumio[1178]: info: CorePlayQueue::getTrack 5 Jan 27 17:38:34 volumio volumio[1178]: info: Prefetching next song Jan 27 17:38:34 volumio volumio[1178]: info: [1769531914123] ControllerQobuz::prefetch Jan 27 17:38:34 volumio volumio[1178]: info: getStreamUrl took 250 milliseconds Jan 27 17:38:34 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand load "https://streaming-qobuz-std.akamaized.net/file?uid=2299643&eid=353014497&fmt=7&profile=raw&app_id=539451548&cid=3761946&etsp=1769535514&hmac=UpuprHYbYZnBf_6vgO39opXme0o" Jan 27 17:38:35 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=2299643&eid=353014497&fmt=7&profile=raw&app_id=539451548&cid=3761946&etsp=1769535514&hmac=UpuprHYbYZnBf_6vgO39opXme0o" Jan 27 17:38:35 volumio volumio[1178]: info: Jan 27 17:38:35 volumio volumio[1178]: ---------------------------- MPD announces system playlist update Jan 27 17:38:35 volumio volumio[1178]: info: Ignoring MPD Status Update Jan 27 17:38:35 volumio volumio[1178]: info: sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=2299643&eid=353014497&fmt=7&profile=raw&app_id=539451548&cid=3761946&etsp=1769535514&hmac=UpuprHYbYZnBf_6vgO39opXme0o" took 4 milliseconds Jan 27 17:38:35 volumio volumio[1178]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 27 17:38:35 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand consume 1 Jan 27 17:38:35 volumio volumio[1178]: info: Jan 27 17:38:35 volumio volumio[1178]: ---------------------------- MPD announces system playlist update Jan 27 17:38:35 volumio volumio[1178]: info: Ignoring MPD Status Update Jan 27 17:38:35 volumio volumio[1178]: info: Jan 27 17:38:35 volumio volumio[1178]: ---------------------------- MPD announces state update: options Jan 27 17:38:35 volumio volumio[1178]: info: ------------------------------ 7ms Jan 27 17:38:35 volumio volumio[1178]: info: sendMpdCommand consume 1 took 5 milliseconds Jan 27 17:38:35 volumio volumio[1178]: info: ControllerMpd::getState Jan 27 17:38:35 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status Jan 27 17:38:35 volumio volumio[1178]: info: ------------------------------ 4ms Jan 27 17:38:35 volumio volumio[1178]: info: Jan 27 17:38:35 volumio volumio[1178]: ---------------------------- MPD announces state update: options Jan 27 17:38:35 volumio volumio[1178]: info: ControllerMpd::getState Jan 27 17:38:35 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status Jan 27 17:38:35 volumio volumio[1178]: info: sendMpdCommand status took 4 milliseconds Jan 27 17:38:35 volumio volumio[1178]: info: sendMpdCommand status took 2 milliseconds Jan 27 17:38:35 volumio volumio[1178]: verbose: ControllerMpd::parseState Jan 27 17:38:35 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 17:38:35 volumio volumio[1178]: verbose: ControllerMpd::parseState Jan 27 17:38:35 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 17:38:35 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 27 17:38:35 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo Jan 27 17:38:35 volumio volumio[1178]: info: ControllerMpd::pushState Jan 27 17:38:35 volumio volumio[1178]: info: CoreCommandRouter::servicePushState Jan 27 17:38:35 volumio volumio[1178]: info: CorePlayQueue::getTrack 4 Jan 27 17:38:35 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":155739,"duration":159,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2063 Kbps","isStreaming":false,"title":"file?uid=2299643&eid=353014496&fmt=7&profile=raw&app_id=539451548&cid=3761946&etsp=1769535360&hmac=RSRmcw_gU5JXS2wIAPjOYzc73fc","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=2299643&eid=353014496&fmt=7&profile=raw&app_id=539451548&cid=3761946&etsp=1769535360&hmac=RSRmcw_gU5JXS2wIAPjOYzc73fc","trackType":"qobuz"} Jan 27 17:38:35 volumio volumio[1178]: verbose: CURRENT POSITION 4 Jan 27 17:38:35 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play Jan 27 17:38:35 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play Jan 27 17:38:35 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload Jan 27 17:38:35 volumio volumio[1178]: info: CoreStateMachine::pushState Jan 27 17:38:35 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 17:38:35 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState Jan 27 17:38:35 volumio volumio[1178]: info: MRS: Pushing multiroomSync output update for this device Jan 27 17:38:35 volumio volumio[1178]: info: MRS: Pushing multiroomSync output Jan 27 17:38:35 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:35 volumio volumio[1178]: info: CoreStateMachine::pushState Jan 27 17:38:35 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState Jan 27 17:38:35 volumio volumio[1178]: info: MRS: Pushing multiroomSync output update for this device Jan 27 17:38:35 volumio volumio[1178]: info: MRS: Pushing multiroomSync output Jan 27 17:38:35 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:35 volumio volumio[1178]: info: ------------------------------ 80ms Jan 27 17:38:35 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 73 milliseconds Jan 27 17:38:35 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo Jan 27 17:38:35 volumio volumio[1178]: info: ControllerMpd::pushState Jan 27 17:38:35 volumio volumio[1178]: info: CoreCommandRouter::servicePushState Jan 27 17:38:35 volumio volumio[1178]: info: CorePlayQueue::getTrack 4 Jan 27 17:38:35 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":155739,"duration":159,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2063 Kbps","isStreaming":false,"title":"file?uid=2299643&eid=353014496&fmt=7&profile=raw&app_id=539451548&cid=3761946&etsp=1769535360&hmac=RSRmcw_gU5JXS2wIAPjOYzc73fc","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=2299643&eid=353014496&fmt=7&profile=raw&app_id=539451548&cid=3761946&etsp=1769535360&hmac=RSRmcw_gU5JXS2wIAPjOYzc73fc","trackType":"qobuz"} Jan 27 17:38:35 volumio volumio[1178]: verbose: CURRENT POSITION 4 Jan 27 17:38:35 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play Jan 27 17:38:35 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play Jan 27 17:38:35 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload Jan 27 17:38:35 volumio volumio[1178]: info: CoreStateMachine::pushState Jan 27 17:38:35 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState Jan 27 17:38:35 volumio volumio[1178]: info: MRS: Pushing multiroomSync output update for this device Jan 27 17:38:35 volumio volumio[1178]: info: MRS: Pushing multiroomSync output Jan 27 17:38:35 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:35 volumio volumio[1178]: info: CoreStateMachine::pushState Jan 27 17:38:35 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState Jan 27 17:38:35 volumio volumio[1178]: info: MRS: Pushing multiroomSync output update for this device Jan 27 17:38:35 volumio volumio[1178]: info: MRS: Pushing multiroomSync output Jan 27 17:38:35 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:35 volumio volumio[1178]: info: ------------------------------ 139ms Jan 27 17:38:38 volumio volumio[1178]: info: Jan 27 17:38:38 volumio volumio[1178]: ---------------------------- MPD announces system playlist update Jan 27 17:38:38 volumio volumio[1178]: info: Ignoring MPD Status Update Jan 27 17:38:38 volumio volumio[1178]: info: Jan 27 17:38:38 volumio volumio[1178]: ---------------------------- MPD announces state update: player Jan 27 17:38:38 volumio volumio[1178]: info: ControllerMpd::getState Jan 27 17:38:38 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status Jan 27 17:38:38 volumio volumio[1178]: info: Jan 27 17:38:38 volumio volumio[1178]: ---------------------------- MPD announces system playlist update Jan 27 17:38:38 volumio volumio[1178]: info: Ignoring MPD Status Update Jan 27 17:38:38 volumio volumio[1178]: info: Jan 27 17:38:38 volumio volumio[1178]: ---------------------------- MPD announces state update: player Jan 27 17:38:38 volumio volumio[1178]: info: ControllerMpd::getState Jan 27 17:38:38 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand status Jan 27 17:38:38 volumio volumio[1178]: info: ------------------------------ 20ms Jan 27 17:38:38 volumio volumio[1178]: info: sendMpdCommand status took 12 milliseconds Jan 27 17:38:38 volumio volumio[1178]: verbose: ControllerMpd::parseState Jan 27 17:38:38 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 17:38:38 volumio volumio[1178]: info: ------------------------------ 16ms Jan 27 17:38:38 volumio volumio[1178]: info: sendMpdCommand status took 10 milliseconds Jan 27 17:38:38 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 27 17:38:38 volumio volumio[1178]: verbose: ControllerMpd::parseState Jan 27 17:38:38 volumio volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 17:38:38 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo Jan 27 17:38:38 volumio volumio[1178]: info: ControllerMpd::pushState Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::servicePushState Jan 27 17:38:38 volumio volumio[1178]: info: CorePlayQueue::getTrack 4 Jan 27 17:38:38 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":129,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1980 Kbps","isStreaming":false,"title":"file?uid=2299643&eid=353014497&fmt=7&profile=raw&app_id=539451548&cid=3761946&etsp=1769535514&hmac=UpuprHYbYZnBf_6vgO39opXme0o","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=2299643&eid=353014497&fmt=7&profile=raw&app_id=539451548&cid=3761946&etsp=1769535514&hmac=UpuprHYbYZnBf_6vgO39opXme0o","trackType":"qobuz"} Jan 27 17:38:38 volumio volumio[1178]: verbose: CURRENT POSITION 4 Jan 27 17:38:38 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play Jan 27 17:38:38 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play Jan 27 17:38:38 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload Jan 27 17:38:38 volumio volumio[1178]: info: CoreStateMachine::pushState Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState Jan 27 17:38:38 volumio volumio[1178]: info: MRS: Pushing multiroomSync output update for this device Jan 27 17:38:38 volumio volumio[1178]: info: MRS: Pushing multiroomSync output Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:38 volumio volumio[1178]: info: CoreStateMachine::pushState Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState Jan 27 17:38:38 volumio volumio[1178]: info: MRS: Pushing multiroomSync output update for this device Jan 27 17:38:38 volumio volumio[1178]: info: MRS: Pushing multiroomSync output Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:38 volumio volumio[1178]: info: ------------------------------ 117ms Jan 27 17:38:38 volumio volumio[1178]: info: sendMpdCommand playlistinfo took 92 milliseconds Jan 27 17:38:38 volumio volumio[1178]: verbose: ControllerMpd::parseTrackInfo Jan 27 17:38:38 volumio volumio[1178]: info: ControllerMpd::pushState Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::servicePushState Jan 27 17:38:38 volumio volumio[1178]: info: CorePlayQueue::getTrack 4 Jan 27 17:38:38 volumio volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":129,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1980 Kbps","isStreaming":false,"title":"file?uid=2299643&eid=353014497&fmt=7&profile=raw&app_id=539451548&cid=3761946&etsp=1769535514&hmac=UpuprHYbYZnBf_6vgO39opXme0o","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=2299643&eid=353014497&fmt=7&profile=raw&app_id=539451548&cid=3761946&etsp=1769535514&hmac=UpuprHYbYZnBf_6vgO39opXme0o","trackType":"qobuz"} Jan 27 17:38:38 volumio volumio[1178]: verbose: CURRENT POSITION 4 Jan 27 17:38:38 volumio volumio[1178]: info: CoreStateMachine::syncState stateService play Jan 27 17:38:38 volumio volumio[1178]: info: CoreStateMachine::syncState currentStatus play Jan 27 17:38:38 volumio volumio[1178]: info: Received an update from plugin. extracting info from payload Jan 27 17:38:38 volumio volumio[1178]: info: CoreStateMachine::pushState Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState Jan 27 17:38:38 volumio volumio[1178]: info: MRS: Pushing multiroomSync output update for this device Jan 27 17:38:38 volumio volumio[1178]: info: MRS: Pushing multiroomSync output Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:38 volumio volumio[1178]: info: CoreStateMachine::pushState Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState Jan 27 17:38:38 volumio volumio[1178]: info: MRS: Pushing multiroomSync output update for this device Jan 27 17:38:38 volumio volumio[1178]: info: MRS: Pushing multiroomSync output Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:38 volumio volumio[1178]: info: ------------------------------ 168ms Jan 27 17:38:38 volumio volumio[1178]: info: Starting Uninstall of plugin system_hardware - mpd_oled Jan 27 17:38:38 volumio volumio[1178]: info: Uninstalling plugin mpd_oled Jan 27 17:38:38 volumio volumio[1178]: info: Disabling plugin mpd_oled Jan 27 17:38:38 volumio volumio[1178]: info: Preparing to generate the ALSA configuration file Jan 27 17:38:38 volumio volumio[1178]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 27 17:38:38 volumio volumio[1178]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 27 17:38:38 volumio volumio[1178]: info: Reading ALSA contributions from plugins. Jan 27 17:38:38 volumio volumio[1178]: info: Asound.conf file unchanged, so no further update is needed Jan 27 17:38:38 volumio volumio[1178]: info: Output device has changed, restarting MPD Jan 27 17:38:38 volumio volumio[1178]: info: Output device has changed, restarting Shairport Sync Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 17:38:38 volumio sudo[5032]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 27 17:38:38 volumio volumio[1178]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 27 17:38:38 volumio volumio[1178]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 27 17:38:38 volumio sudo[5032]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:38 volumio volumio[1178]: info: QobuzConnect: setDeactiveState invoked Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:38 volumio sudo[5032]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:38 volumio sudo[5034]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 27 17:38:38 volumio sudo[5034]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:38 volumio vtcs[4668]: [2026-01-27 17:38:38.649] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jan 27 17:38:38 volumio vtcs[4668]: [2026-01-27 17:38:38.649] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jan 27 17:38:38 volumio volumio[1178]: info: Checking if uninstall.sh is present Jan 27 17:38:38 volumio sudo[5044]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 27 17:38:38 volumio sudo[5044]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:38 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 27 17:38:38 volumio sudo[5048]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 27 17:38:38 volumio sudo[5048]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:38 volumio volumio[1178]: info: CoreStateMachine::startPlaybackTimer Jan 27 17:38:38 volumio volumio[1178]: info: CorePlayQueue::getTrack 5 Jan 27 17:38:38 volumio volumio[1178]: info: Executing uninstall.sh Jan 27 17:38:38 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jan 27 17:38:38 volumio systemd[1]: vtcs.service: Killing process 4671 (vtcs) with signal SIGKILL. Jan 27 17:38:38 volumio systemd[1]: vtcs.service: Deactivated successfully. Jan 27 17:38:38 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jan 27 17:38:38 volumio sudo[5054]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 27 17:38:38 volumio sudo[5054]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:38 volumio sudo[5044]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:38 volumio volumio[1178]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jan 27 17:38:38 volumio volumio[1178]: info: MPD Permissions set Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:38 volumio sudo[5054]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:38 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:38 volumio sudo[5057]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/system_hardware/mpd_oled/uninstall.sh Jan 27 17:38:38 volumio sudo[5057]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:38 volumio sudo[5048]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:38 volumio sudo[5060]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 27 17:38:38 volumio sudo[5060]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 27 17:38:39 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 27 17:38:39 volumio systemd[1]: mpd.service: Consumed 25.901s CPU time. Jan 27 17:38:39 volumio volumio[1178]: info: Starting Shairport Sync Jan 27 17:38:39 volumio volumio[1178]: info: Preparing to generate the ALSA configuration file Jan 27 17:38:39 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 27 17:38:39 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 27 17:38:39 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 27 17:38:39 volumio sudo[5072]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 27 17:38:39 volumio sudo[5072]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio volumio[1178]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 27 17:38:39 volumio volumio[1178]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 27 17:38:39 volumio volumio[1178]: info: Reading ALSA contributions from plugins. Jan 27 17:38:39 volumio volumio[1178]: info: Asound.conf file unchanged, so no further update is needed Jan 27 17:38:39 volumio volumio[1178]: info: Output device has changed, restarting MPD Jan 27 17:38:39 volumio volumio[1178]: info: Output device has changed, restarting Shairport Sync Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 17:38:39 volumio sudo[5076]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 27 17:38:39 volumio sudo[5076]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio sudo[5076]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:39 volumio sudo[5078]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 27 17:38:39 volumio sudo[5078]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio volumio[1178]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 27 17:38:39 volumio volumio[1178]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: QobuzConnect: setDeactiveState invoked Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:39 volumio volumio[1178]: info: CorePlayQueue::getTrack 5 Jan 27 17:38:39 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 27 17:38:39 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 27 17:38:39 volumio sudo[5089]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 27 17:38:39 volumio sudo[5089]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio volumio[1178]: info: CoreStateMachine::pushState Jan 27 17:38:39 volumio volumio[1178]: info: CorePlayQueue::getTrack 5 Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::volumioPushState Jan 27 17:38:39 volumio sudo[5092]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 27 17:38:39 volumio sudo[5092]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio systemd[1]: Reloading. Jan 27 17:38:39 volumio volumio[1178]: info: MRS: Pushing multiroomSync output update for this device Jan 27 17:38:39 volumio volumio[1178]: info: MRS: Pushing multiroomSync output Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:39 volumio volumio[1178]: info: CorePlayQueue::getTrack 5 Jan 27 17:38:39 volumio sudo[5098]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 27 17:38:39 volumio sudo[5098]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio volumio[1178]: info: MPD Permissions set Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio sudo[5088]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 27 17:38:39 volumio sudo[5088]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 17:38:39 volumio volumio[1178]: info: Starting Shairport Sync Jan 27 17:38:39 volumio sudo[5088]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:39 volumio volumio[1178]: info: Preparing to generate the ALSA configuration file Jan 27 17:38:39 volumio volumio[1178]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 27 17:38:39 volumio volumio[1178]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 27 17:38:39 volumio volumio[1178]: info: Reading ALSA contributions from plugins. Jan 27 17:38:39 volumio volumio[1178]: info: Asound.conf file unchanged, so no further update is needed Jan 27 17:38:39 volumio volumio[1178]: info: Output device has changed, restarting MPD Jan 27 17:38:39 volumio volumio[1178]: info: Output device has changed, restarting Shairport Sync Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 17:38:39 volumio sudo[5112]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 27 17:38:39 volumio sudo[5117]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 27 17:38:39 volumio sudo[5114]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 27 17:38:39 volumio sudo[5114]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio sudo[5112]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio sudo[5117]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio sudo[5114]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:39 volumio volumio[1178]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 27 17:38:39 volumio volumio[1178]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: QobuzConnect: setDeactiveState invoked Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:39 volumio volumio[1178]: info: CorePlayQueue::getTrack 5 Jan 27 17:38:39 volumio sudo[5144]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 27 17:38:39 volumio sudo[5144]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio sudo[5146]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 27 17:38:39 volumio sudo[5146]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio volumio[1178]: info: MPD Permissions set Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio sudo[5154]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 27 17:38:39 volumio sudo[5154]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 17:38:39 volumio volumio[1178]: info: Starting Shairport Sync Jan 27 17:38:39 volumio sudo[5162]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 27 17:38:39 volumio sudo[5162]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:40 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jan 27 17:38:40 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jan 27 17:38:41 volumio sudo[5164]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm /etc/systemd/system/mpd_oled_plugin.service Jan 27 17:38:41 volumio sudo[5164]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 17:38:41 volumio sudo[5164]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:41 volumio sudo[5098]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:41 volumio sudo[5168]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 27 17:38:41 volumio sudo[5168]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:41 volumio sudo[5154]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:41 volumio sudo[5170]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 27 17:38:41 volumio sudo[5170]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:41 volumio systemd[1]: Reloading. Jan 27 17:38:41 volumio volumio[1178]: info: TidalConnect service stoped! Jan 27 17:38:41 volumio volumio[1178]: info: TidalConnect service stoped! Jan 27 17:38:42 volumio volumio[1178]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 27 17:38:42 volumio volumio[1178]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 27 17:38:42 volumio sudo[5212]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 27 17:38:42 volumio sudo[5212]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 17:38:42 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jan 27 17:38:42 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jan 27 17:38:42 volumio volumio[1178]: info: CoreCommandRouter::volumioGetState Jan 27 17:38:42 volumio volumio[1178]: info: CorePlayQueue::getTrack 5 Jan 27 17:38:42 volumio volumio[1178]: info: Listing playlists Jan 27 17:38:42 volumio volumio[1178]: info: Listing playlists Jan 27 17:38:43 volumio sudo[5092]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:43 volumio sudo[5144]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:43 volumio sudo[5146]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:43 volumio volumio[1178]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Jan 27 17:38:43 volumio volumio[1178]: Job for vtcs.service canceled. Jan 27 17:38:43 volumio volumio[1178]: {"cmd":"/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3","code":1,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3\nJob for vtcs.service canceled.\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)","stderr":"Job for vtcs.service canceled.\n","stdout":""} Jan 27 17:38:43 volumio sudo[5089]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:43 volumio volumio[1178]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 27 17:38:43 volumio volumio[1178]: Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Jan 27 17:38:43 volumio volumio[1178]: Job for vtcs.service canceled. Jan 27 17:38:43 volumio volumio[1178]: at ChildProcess.exithandler (node:child_process:421:12) Jan 27 17:38:43 volumio volumio[1178]: at ChildProcess.emit (node:events:514:28) Jan 27 17:38:43 volumio volumio[1178]: at maybeClose (node:internal/child_process:1105:16) Jan 27 17:38:43 volumio volumio[1178]: at Socket. (node:internal/child_process:457:11) Jan 27 17:38:43 volumio volumio[1178]: at Socket.emit (node:events:514:28) Jan 27 17:38:43 volumio volumio[1178]: at Pipe. (node:net:337:12) { Jan 27 17:38:43 volumio volumio[1178]: code: 1, Jan 27 17:38:43 volumio volumio[1178]: killed: false, Jan 27 17:38:43 volumio volumio[1178]: signal: null, Jan 27 17:38:43 volumio volumio[1178]: cmd: '/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3', Jan 27 17:38:43 volumio volumio[1178]: stdout: '', Jan 27 17:38:43 volumio volumio[1178]: stderr: 'Job for vtcs.service canceled.\n' Jan 27 17:38:43 volumio volumio[1178]: } Jan 27 17:38:43 volumio volumio[1178]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 27 17:38:43 volumio qobuz-connect[4635]: 20260127 17:38:43.407 [4635.4635] INFO SampleApp: Stopping Local configuration server Jan 27 17:38:43 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jan 27 17:38:43 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 27 17:38:43 volumio sudo[5230]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /usr/local/bin/mpd_oled /usr/local/bin/mpd_oled_cava Jan 27 17:38:43 volumio sudo[5230]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 17:38:43 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jan 27 17:38:43 volumio sudo[5230]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:43 volumio sudo[5212]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:43 volumio sudo[5057]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:43 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 27 17:38:43 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 27 17:38:43 volumio systemd[1]: shairport-sync.service: Consumed 2.545s CPU time. Jan 27 17:38:43 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 27 17:38:43 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 27 17:38:43 volumio systemd[1]: mpd.service: Consumed 2.494s CPU time. Jan 27 17:38:43 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 27 17:38:43 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 27 17:38:43 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 27 17:38:43 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 27 17:38:43 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 27 17:38:43 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 27 17:38:43 volumio sudo[5112]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:43 volumio sudo[5162]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:43 volumio sudo[5072]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:43 volumio sudo[5236]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 27 17:38:43 volumio sudo[5236]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 17:38:43 volumio sudo[5236]: pam_unix(sudo:session): session closed for user root Jan 27 17:38:44 volumio sudo[5257]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-27 17:37' Jan 27 17:38:44 volumio sudo[5257]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"