-- Logs begin at Sat 2025-02-15 11:06:26 CET, end at Sat 2025-02-15 12:06:36 CET. --
Feb 15 12:05:06 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Feb 15 12:05:07 rivo volumio[3274]: info: handleBrowseUri took 344 milliseconds
Feb 15 12:05:07 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991485
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991486
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991487
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991488
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991489
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991490
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991491
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991492
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991493
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991494
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991495
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991496
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991497
Feb 15 12:05:07 rivo volumio[3274]: info: Preloading song: qobuz://song/186991498
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991485 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991486 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991487 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991488 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991489 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991490 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991491 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991492 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991493 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991494 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991495 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991496 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991497 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:07 rivo volumio[3274]: info: Exploding uri qobuz://song/186991498 in service qobuz
Feb 15 12:05:07 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:20 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::ClearQueue
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::stop
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::stPlaybackTimer
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:05:20 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::pushState
Feb 15 12:05:20 rivo volumio[3274]: info: CorePlayQueue::getTrack 1
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::volumioPushState
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output update for this device
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::serviceStop
Feb 15 12:05:20 rivo volumio[3274]: info: CorePlayQueue::getTrack 1
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::serviceStop
Feb 15 12:05:20 rivo volumio[3274]: info: [1739617520537] ControllerQobuz::stop
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 15 12:05:20 rivo volumio[3274]: info: ControllerMpd::stop
Feb 15 12:05:20 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand stop
Feb 15 12:05:20 rivo volumio[3274]: info: CorePlayQueue::clearPlayQueue
Feb 15 12:05:20 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::addQueueItems
Feb 15 12:05:20 rivo volumio[3274]: info: CorePlayQueue::addQueueItems
Feb 15 12:05:20 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:05:20 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991485
Feb 15 12:05:20 rivo volumio[3274]: info: Exploding uri qobuz://song/186991485 in service qobuz
Feb 15 12:05:20 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:20 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991486
Feb 15 12:05:20 rivo volumio[3274]: info: Exploding uri qobuz://song/186991486 in service qobuz
Feb 15 12:05:20 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:20 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991487
Feb 15 12:05:20 rivo volumio[3274]: info: Exploding uri qobuz://song/186991487 in service qobuz
Feb 15 12:05:20 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:20 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991488
Feb 15 12:05:20 rivo volumio[3274]: info: Exploding uri qobuz://song/186991488 in service qobuz
Feb 15 12:05:20 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:20 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991489
Feb 15 12:05:20 rivo volumio[3274]: info: Exploding uri qobuz://song/186991489 in service qobuz
Feb 15 12:05:20 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:20 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991490
Feb 15 12:05:20 rivo volumio[3274]: info: Exploding uri qobuz://song/186991490 in service qobuz
Feb 15 12:05:20 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:20 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991491
Feb 15 12:05:20 rivo volumio[3274]: info: Exploding uri qobuz://song/186991491 in service qobuz
Feb 15 12:05:20 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:20 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991492
Feb 15 12:05:20 rivo volumio[3274]: info: Exploding uri qobuz://song/186991492 in service qobuz
Feb 15 12:05:20 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:20 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991493
Feb 15 12:05:20 rivo volumio[3274]: info: Exploding uri qobuz://song/186991493 in service qobuz
Feb 15 12:05:20 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:20 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991494
Feb 15 12:05:20 rivo volumio[3274]: info: Exploding uri qobuz://song/186991494 in service qobuz
Feb 15 12:05:20 rivo volumio[3274]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Feb 15 12:05:20 rivo volumio[3274]: info: Updating RAAT Signal Path
Feb 15 12:05:20 rivo volumio[3274]: info:
Feb 15 12:05:20 rivo volumio[3274]: ---------------------------- MPD announces state update: player
Feb 15 12:05:20 rivo volumio[3274]: info: sendMpdCommand stop took 110 milliseconds
Feb 15 12:05:20 rivo volumio[3274]: info: ControllerMpd::getState
Feb 15 12:05:20 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand status
Feb 15 12:05:20 rivo volumio[3274]: info: sendMpdCommand status took 3 milliseconds
Feb 15 12:05:20 rivo volumio[3274]: verbose: ControllerMpd::parseState
Feb 15 12:05:20 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 15 12:05:20 rivo volumio[3274]: info:
Feb 15 12:05:20 rivo volumio[3274]: ---------------------------- MPD announces state update: player
Feb 15 12:05:20 rivo volumio[3274]: info: ControllerMpd::getState
Feb 15 12:05:20 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand status
Feb 15 12:05:20 rivo volumio[3274]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 15 12:05:20 rivo volumio[3274]: info: sendMpdCommand status took 3 milliseconds
Feb 15 12:05:20 rivo volumio[3274]: verbose: ControllerMpd::parseTrackInfo
Feb 15 12:05:20 rivo volumio[3274]: verbose: ControllerMpd::parseState
Feb 15 12:05:20 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 15 12:05:20 rivo volumio[3274]: info: ControllerMpd::pushState
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::servicePushState
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::pushState
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::volumioPushState
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output update for this device
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output
Feb 15 12:05:20 rivo volumio[3274]: info: CorePlayQueue::getTrack 1
Feb 15 12:05:20 rivo volumio[3274]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"259259184","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/259259184","trackType":"qobuz"}
Feb 15 12:05:20 rivo volumio[3274]: verbose: CURRENT POSITION 1
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::syncState stateService stop
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::syncState currentStatus stop
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::pushState
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::volumioPushState
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output update for this device
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output
Feb 15 12:05:20 rivo volumio[3274]: info: No code
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::pushState
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::volumioPushState
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output update for this device
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output
Feb 15 12:05:20 rivo volumio[3274]: info: ------------------------------ 113ms
Feb 15 12:05:20 rivo volumio[3274]: info: sendMpdCommand playlistinfo took 105 milliseconds
Feb 15 12:05:20 rivo volumio[3274]: verbose: ControllerMpd::parseTrackInfo
Feb 15 12:05:20 rivo volumio[3274]: info: ControllerMpd::pushState
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::servicePushState
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::pushState
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::volumioPushState
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output update for this device
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output
Feb 15 12:05:20 rivo volumio[3274]: info: CorePlayQueue::getTrack 1
Feb 15 12:05:20 rivo volumio[3274]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"259259184","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/259259184","trackType":"qobuz"}
Feb 15 12:05:20 rivo volumio[3274]: verbose: CURRENT POSITION 1
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::syncState stateService stop
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::syncState currentStatus stop
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::pushState
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::volumioPushState
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output update for this device
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output
Feb 15 12:05:20 rivo volumio[3274]: info: No code
Feb 15 12:05:20 rivo volumio[3274]: info: CoreStateMachine::pushState
Feb 15 12:05:20 rivo volumio[3274]: info: CoreCommandRouter::volumioPushState
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output update for this device
Feb 15 12:05:20 rivo volumio[3274]: info: MRS: Pushing multiroomSync output
Feb 15 12:05:20 rivo volumio[3274]: info: ------------------------------ 283ms
Feb 15 12:05:21 rivo volumio[3274]: info: Updating RAAT Signal Path
Feb 15 12:05:21 rivo volumio[3274]: info: Updating RAAT Signal Path
Feb 15 12:05:21 rivo volumio[3274]: info: Updating RAAT Signal Path
Feb 15 12:05:21 rivo volumio[3274]: info: Updating RAAT Signal Path
Feb 15 12:05:21 rivo volumio[3274]: info: Updating RAAT Signal Path
Feb 15 12:05:21 rivo volumio[3274]: info: Updating RAAT Signal Path
Feb 15 12:05:21 rivo volumio[3274]: info: explodeUri took 14571 milliseconds
Feb 15 12:05:21 rivo volumio[3274]: info: explodeUri took 14476 milliseconds
Feb 15 12:05:21 rivo volumio[3274]: info: explodeUri took 14402 milliseconds
Feb 15 12:05:21 rivo volumio[3274]: info: explodeUri took 1357 milliseconds
Feb 15 12:05:21 rivo volumio[3274]: info: explodeUri took 14364 milliseconds
Feb 15 12:05:21 rivo volumio[3274]: info: explodeUri took 1379 milliseconds
Feb 15 12:05:21 rivo volumio[3274]: info: explodeUri took 1382 milliseconds
Feb 15 12:05:21 rivo volumio[3274]: info: explodeUri took 14587 milliseconds
Feb 15 12:05:21 rivo volumio[3274]: info: explodeUri took 14307 milliseconds
Feb 15 12:05:21 rivo volumio[3274]: info: explodeUri took 14369 milliseconds
Feb 15 12:05:21 rivo volumio[3274]: info: explodeUri took 1427 milliseconds
Feb 15 12:05:21 rivo volumio[3274]: info: explodeUri took 14553 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: info: explodeUri took 14156 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: info: explodeUri took 1447 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: info: explodeUri took 1478 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: info: explodeUri took 14097 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: info: explodeUri took 14279 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: info: explodeUri took 1523 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: info: explodeUri took 1550 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: info: explodeUri took 1590 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: info: explodeUri took 14322 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: info: explodeUri took 1660 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:05:22 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:05:22 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:05:22 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:05:22 rivo volumio[3274]: info: CoreCommandRouter::volumioPlay
Feb 15 12:05:22 rivo volumio[3274]: info: CoreStateMachine::play index 9
Feb 15 12:05:22 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:05:22 rivo volumio[3274]: info: CoreStateMachine::addQueueItems
Feb 15 12:05:22 rivo volumio[3274]: info: CorePlayQueue::addQueueItems
Feb 15 12:05:22 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:05:22 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991495
Feb 15 12:05:22 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991495
Feb 15 12:05:22 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991496
Feb 15 12:05:22 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991496
Feb 15 12:05:22 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991497
Feb 15 12:05:22 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991497
Feb 15 12:05:22 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991498
Feb 15 12:05:22 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991498
Feb 15 12:05:22 rivo volumio[3274]: info: CoreStateMachine::stop
Feb 15 12:05:22 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:05:22 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:05:22 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:05:22 rivo volumio[3274]: info: CoreStateMachine::play index undefined
Feb 15 12:05:22 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:05:22 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:05:22 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:05:22 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:22 rivo volumio[3274]: info: CoreStateMachine::startPlaybackTimer
Feb 15 12:05:22 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:22 rivo volumio[3274]: info: [1739617522277] ControllerQobuz::clearAddPlayTrack
Feb 15 12:05:22 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand stop
Feb 15 12:05:22 rivo volumio[3274]: info: sendMpdCommand stop took 9 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand clear
Feb 15 12:05:22 rivo volumio[3274]: info:
Feb 15 12:05:22 rivo volumio[3274]: ---------------------------- MPD announces system playlist update
Feb 15 12:05:22 rivo volumio[3274]: info: Ignoring MPD Status Update
Feb 15 12:05:22 rivo volumio[3274]: info: sendMpdCommand clear took 2 milliseconds
Feb 15 12:05:22 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/186991494"
Feb 15 12:05:22 rivo volumio[3274]: info:
Feb 15 12:05:22 rivo volumio[3274]: ---------------------------- MPD announces system playlist update
Feb 15 12:05:22 rivo volumio[3274]: info: Ignoring MPD Status Update
Feb 15 12:05:22 rivo volumio[3274]: STREAMING PROXY: Handling url /?data=qobuz://song/186991494
Feb 15 12:05:22 rivo volumio[3274]: error: updateQueue error: null
Feb 15 12:05:22 rivo volumio[3274]: info: ------------------------------ 5ms
Feb 15 12:05:22 rivo volumio[3274]: info: Executing endpoint getStreamUrlqobuz
Feb 15 12:05:22 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Feb 15 12:05:28 rivo systemd[1]: Stopping Music Player Daemon...
Feb 15 12:05:29 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:05:29 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:05:29 rivo volumio[3274]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::ClearQueue
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::stop
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:05:29 rivo volumio[3274]: info: CorePlayQueue::clearPlayQueue
Feb 15 12:05:29 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:05:29 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::addQueueItems
Feb 15 12:05:29 rivo volumio[3274]: info: CorePlayQueue::addQueueItems
Feb 15 12:05:29 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991485
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991485
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991486
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991486
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991487
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991487
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991488
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991488
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991489
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991489
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991490
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991490
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991491
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991491
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991492
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991492
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991493
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991493
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991494
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991494
Feb 15 12:05:29 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:05:29 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:05:29 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:05:29 rivo volumio[3274]: info: CoreCommandRouter::volumioPlay
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::play index 9
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::addQueueItems
Feb 15 12:05:29 rivo volumio[3274]: info: CorePlayQueue::addQueueItems
Feb 15 12:05:29 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991495
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991495
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991496
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991496
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991497
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991497
Feb 15 12:05:29 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991498
Feb 15 12:05:29 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991498
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::stop
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:05:29 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:05:29 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::play index undefined
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:05:29 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:05:29 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:29 rivo volumio[3274]: info: CoreStateMachine::startPlaybackTimer
Feb 15 12:05:29 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:29 rivo volumio[3274]: info: [1739617529050] ControllerQobuz::clearAddPlayTrack
Feb 15 12:05:29 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand stop
Feb 15 12:05:36 rivo volumio[3274]: verbose: New Socket.io Connection to 192.168.0.55 from 192.168.0.149 UA: Mozilla/5.0 (Linux; Android 12; SM-T865 Build/SP2A.220305.013; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.163 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::volumioGetState
Feb 15 12:05:36 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:36 rivo volumio[3274]: info: Received Get System Info
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 15 12:05:36 rivo volumio[3274]: info: Discovery: Getting this device information
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::volumioGetState
Feb 15 12:05:36 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::volumioGetState
Feb 15 12:05:36 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::volumioGetState
Feb 15 12:05:36 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::volumioGetState
Feb 15 12:05:36 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 15 12:05:36 rivo volumio[3274]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Feb 15 12:05:36 rivo volumio[3274]: info: Received Get System Info
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 15 12:05:36 rivo volumio[3274]: info: Discovery: Getting this device information
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::volumioGetState
Feb 15 12:05:36 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::volumioGetState
Feb 15 12:05:36 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:36 rivo volumio[3274]: info: Listing playlists
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::volumioGetQueue
Feb 15 12:05:36 rivo volumio[3274]: info: CoreStateMachine::getQueue
Feb 15 12:05:36 rivo volumio[3274]: info: CorePlayQueue::getQueue
Feb 15 12:05:36 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 15 12:05:45 rivo volumio[3274]: info: CoreCommandRouter::volumioPlay
Feb 15 12:05:45 rivo volumio[3274]: info: CoreStateMachine::play index undefined
Feb 15 12:05:45 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:05:45 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:45 rivo volumio[3274]: info: CoreStateMachine::startPlaybackTimer
Feb 15 12:05:45 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:05:45 rivo volumio[3274]: info: [1739617545403] ControllerQobuz::clearAddPlayTrack
Feb 15 12:05:45 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand stop
Feb 15 12:05:46 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 15 12:06:06 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:06:06 rivo volumio[3274]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::ClearQueue
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::stop
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::clearPlayQueue
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:06:06 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::addQueueItems
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::addQueueItems
Feb 15 12:06:06 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991485
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991485
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991486
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991486
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991487
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991487
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991488
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991488
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991489
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991489
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991490
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991490
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991491
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991491
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991492
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991492
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991493
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991493
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991494
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991494
Feb 15 12:06:06 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:06:06 rivo volumio[3274]: info: CoreCommandRouter::volumioPlay
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::play index 9
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::addQueueItems
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::addQueueItems
Feb 15 12:06:06 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991495
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991495
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991496
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991496
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991497
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991497
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991498
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991498
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::stop
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:06 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::play index undefined
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::startPlaybackTimer
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:06:06 rivo volumio[3274]: info: [1739617566887] ControllerQobuz::clearAddPlayTrack
Feb 15 12:06:06 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand stop
Feb 15 12:06:06 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:06:06 rivo volumio[3274]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::ClearQueue
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::stop
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::clearPlayQueue
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:06:06 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:06:06 rivo volumio[3274]: info: CoreStateMachine::addQueueItems
Feb 15 12:06:06 rivo volumio[3274]: info: CorePlayQueue::addQueueItems
Feb 15 12:06:06 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991485
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991485
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991486
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991486
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991487
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991487
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991488
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991488
Feb 15 12:06:06 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991489
Feb 15 12:06:06 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991489
Feb 15 12:06:07 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991490
Feb 15 12:06:07 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991490
Feb 15 12:06:07 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991491
Feb 15 12:06:07 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991491
Feb 15 12:06:07 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991492
Feb 15 12:06:07 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991492
Feb 15 12:06:07 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991493
Feb 15 12:06:07 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991493
Feb 15 12:06:07 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991494
Feb 15 12:06:07 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991494
Feb 15 12:06:07 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:06:07 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:06:07 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:06:07 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:06:07 rivo volumio[3274]: info: CoreCommandRouter::volumioPlay
Feb 15 12:06:07 rivo volumio[3274]: info: CoreStateMachine::play index 9
Feb 15 12:06:07 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:07 rivo volumio[3274]: info: CoreStateMachine::addQueueItems
Feb 15 12:06:07 rivo volumio[3274]: info: CorePlayQueue::addQueueItems
Feb 15 12:06:07 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:06:07 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991495
Feb 15 12:06:07 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991495
Feb 15 12:06:07 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991496
Feb 15 12:06:07 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991496
Feb 15 12:06:07 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991497
Feb 15 12:06:07 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991497
Feb 15 12:06:07 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991498
Feb 15 12:06:07 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991498
Feb 15 12:06:07 rivo volumio[3274]: info: CoreStateMachine::stop
Feb 15 12:06:07 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:07 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:06:07 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:06:07 rivo volumio[3274]: info: CoreStateMachine::play index undefined
Feb 15 12:06:07 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:07 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:06:07 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:06:07 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:06:07 rivo volumio[3274]: info: CoreStateMachine::startPlaybackTimer
Feb 15 12:06:07 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:06:07 rivo volumio[3274]: info: [1739617567027] ControllerQobuz::clearAddPlayTrack
Feb 15 12:06:07 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand stop
Feb 15 12:06:11 rivo volumio[3274]: info: CoreCommandRouter::volumioPlay
Feb 15 12:06:11 rivo volumio[3274]: info: CoreStateMachine::play index undefined
Feb 15 12:06:11 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:11 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:06:11 rivo volumio[3274]: info: CoreStateMachine::startPlaybackTimer
Feb 15 12:06:11 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:06:11 rivo volumio[3274]: info: [1739617571721] ControllerQobuz::clearAddPlayTrack
Feb 15 12:06:11 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand stop
Feb 15 12:06:14 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:06:14 rivo volumio[3274]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::ClearQueue
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::stop
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:14 rivo volumio[3274]: info: CorePlayQueue::clearPlayQueue
Feb 15 12:06:14 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:06:14 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::addQueueItems
Feb 15 12:06:14 rivo volumio[3274]: info: CorePlayQueue::addQueueItems
Feb 15 12:06:14 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991485
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991485
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991486
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991486
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991487
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991487
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991488
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991488
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991489
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991489
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991490
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991490
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991491
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991491
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991492
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991492
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991493
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991493
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991494
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991494
Feb 15 12:06:14 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:06:14 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:06:14 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:06:14 rivo volumio[3274]: info: CoreCommandRouter::volumioPlay
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::play index 9
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::addQueueItems
Feb 15 12:06:14 rivo volumio[3274]: info: CorePlayQueue::addQueueItems
Feb 15 12:06:14 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991495
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991495
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991496
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991496
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991497
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991497
Feb 15 12:06:14 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991498
Feb 15 12:06:14 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991498
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::stop
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:14 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:06:14 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::play index undefined
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:06:14 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:06:14 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:06:14 rivo volumio[3274]: info: CoreStateMachine::startPlaybackTimer
Feb 15 12:06:14 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:06:14 rivo volumio[3274]: info: [1739617574930] ControllerQobuz::clearAddPlayTrack
Feb 15 12:06:14 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand stop
Feb 15 12:06:16 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:06:16 rivo volumio[3274]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::ClearQueue
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::stop
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:16 rivo volumio[3274]: info: CorePlayQueue::clearPlayQueue
Feb 15 12:06:16 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:06:16 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::addQueueItems
Feb 15 12:06:16 rivo volumio[3274]: info: CorePlayQueue::addQueueItems
Feb 15 12:06:16 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991485
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991485
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991486
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991486
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991487
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991487
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991488
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991488
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991489
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991489
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991490
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991490
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991491
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991491
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991492
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991492
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991493
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991493
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991494
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991494
Feb 15 12:06:16 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:06:16 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:06:16 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:06:16 rivo volumio[3274]: info: CoreCommandRouter::volumioPlay
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::play index 9
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::addQueueItems
Feb 15 12:06:16 rivo volumio[3274]: info: CorePlayQueue::addQueueItems
Feb 15 12:06:16 rivo volumio[3274]: info: Preload queue cleared
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991495
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991495
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991496
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991496
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991497
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991497
Feb 15 12:06:16 rivo volumio[3274]: info: Adding Item to queue: qobuz://song/186991498
Feb 15 12:06:16 rivo volumio[3274]: info: Using cached record of: qobuz://song/186991498
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::stop
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:16 rivo volumio[3274]: info: CoreCommandRouter::volumioPushQueue
Feb 15 12:06:16 rivo volumio[3274]: info: CorePlayQueue::saveQueue
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::play index undefined
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::updateTrackBlock
Feb 15 12:06:16 rivo volumio[3274]: info: CorePlayQueue::getTrackBlock
Feb 15 12:06:16 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:06:16 rivo volumio[3274]: info: CoreStateMachine::startPlaybackTimer
Feb 15 12:06:16 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:06:16 rivo volumio[3274]: info: [1739617576895] ControllerQobuz::clearAddPlayTrack
Feb 15 12:06:16 rivo volumio[3274]: verbose: ControllerMpd::sendMpdCommand stop
Feb 15 12:06:21 rivo volumio[3274]: info: CoreCommandRouter::volumioGetState
Feb 15 12:06:21 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 15 12:06:23 rivo volumio[3274]: info: Retrieving Cloud Streaming UI
Feb 15 12:06:23 rivo volumio[3274]: info: Getting Tidal Cloud Configuration
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 15 12:06:23 rivo volumio[3274]: info: Getting Qobuz Cloud Configuration
Feb 15 12:06:23 rivo volumio[3274]: info: Asking plugin for UI Config
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 15 12:06:23 rivo volumio[3274]: info: Getting Spotify Cloud Configuration
Feb 15 12:06:23 rivo volumio[3274]: info: Asking plugin for UI Config
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 15 12:06:23 rivo volumio[3274]: info: Saving Spotify Acccount
Feb 15 12:06:23 rivo volumio[3274]: info: Got it
Feb 15 12:06:23 rivo volumio[3274]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Feb 15 12:06:23 rivo volumio[3274]: info: Got Tidal Cloud Configuration
Feb 15 12:06:23 rivo volumio[3274]: info: Got it
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 15 12:06:23 rivo volumio[3274]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 15 12:06:25 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 15 12:06:25 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Feb 15 12:06:25 rivo volumio[3274]: info: Executing endpoint metavolumio
Feb 15 12:06:25 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Feb 15 12:06:25 rivo volumio[3274]: info: Executing endpoint metavolumio
Feb 15 12:06:25 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Feb 15 12:06:25 rivo volumio[3274]: info: Executing endpoint metavolumio
Feb 15 12:06:25 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Feb 15 12:06:25 rivo kernel: [35B blob data]
Feb 15 12:06:25 rivo kernel: CFG80211-ERROR) wl_notify_rx_mgmt_frame : TDLS Action Frame Received type = 2
Feb 15 12:06:25 rivo kernel: CFG80211-ERROR) wl_tdls_event_handler : TDLS PEER CONNECTED : 9e:81:aa:f1:09:4b on primary ndev
Feb 15 12:06:27 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 15 12:06:28 rivo volumio[3274]: info: Disabling MyMusic plugin bluetooth
Feb 15 12:06:28 rivo sudo[16785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service
Feb 15 12:06:28 rivo sudo[16785]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:28 rivo systemd[1]: Stopping Volumio Bluetooth Module...
Feb 15 12:06:28 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:28 rivo volumiobt[16787]: Killing pulse
Feb 15 12:06:28 rivo volumiobt[16787]: Killing BT Pair agent
Feb 15 12:06:28 rivo bluetoothd[3201]: Endpoint unregistered: sender=:1.43 path=/MediaEndpoint/A2DPSource
Feb 15 12:06:28 rivo bluetoothd[3201]: Endpoint unregistered: sender=:1.43 path=/MediaEndpoint/A2DPSink
Feb 15 12:06:28 rivo systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM
Feb 15 12:06:28 rivo systemd[1]: volumiobt.service: Succeeded.
Feb 15 12:06:28 rivo systemd[1]: Stopped Volumio Bluetooth Module.
Feb 15 12:06:28 rivo sudo[16785]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:28 rivo volumio[3274]: info: Volumio BT Module successfully stopped
Feb 15 12:06:28 rivo volumio[3274]: info: Disabling plugin bluetooth
Feb 15 12:06:28 rivo volumio[3274]: info: Done.
Feb 15 12:06:29 rivo volumio[3274]: info: Enabling MyMusic plugin bluetooth
Feb 15 12:06:29 rivo volumio[3274]: info: Enabling plugin bluetooth
Feb 15 12:06:29 rivo volumio[3274]: info: Loading plugin "bluetooth"...
Feb 15 12:06:29 rivo volumio[3274]: info: [1739617589871] Starting BluetoothController
Feb 15 12:06:29 rivo volumio[3274]: info: PLUGIN START: bluetooth
Feb 15 12:06:29 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 15 12:06:29 rivo volumio[3274]: info: Done.
Feb 15 12:06:29 rivo sudo[16791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Rivo
Feb 15 12:06:29 rivo sudo[16791]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:29 rivo sudo[16791]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:29 rivo volumio[3274]: info: Bluetooth name changed to Rivo
Feb 15 12:06:31 rivo volumio[3274]: info: Disabling MyMusic plugin multiroom
Feb 15 12:06:31 rivo volumio[3274]: info: Disabling plugin multiroom
Feb 15 12:06:31 rivo volumio[3274]: info: Preparing to generate the ALSA configuration file
Feb 15 12:06:31 rivo volumio[3274]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Feb 15 12:06:31 rivo volumio[3274]: info: Reading ALSA contributions from plugins.
Feb 15 12:06:31 rivo volumio[3274]: info: Asound.conf file written
Feb 15 12:06:31 rivo sudo[16794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Feb 15 12:06:31 rivo sudo[16794]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:31 rivo sudo[16794]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:31 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994
Feb 15 12:06:31 rivo kernel: Err: can not set rate to 4278967296!
Feb 15 12:06:31 rivo kernel: Range[3920000 - 500000000]
Feb 15 12:06:31 rivo kernel: out of value, fixed it
Feb 15 12:06:31 rivo kernel: id=0 set inskew=0
Feb 15 12:06:31 rivo volumio[3274]: No protocol specified
Feb 15 12:06:31 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:31 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted
Feb 15 12:06:31 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted
Feb 15 12:06:31 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted
Feb 15 12:06:31 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted
Feb 15 12:06:31 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Topping Internal Clock Validity:0' : Operation not permitted
Feb 15 12:06:31 rivo volumio[3274]: info: Output device has changed, restarting MPD
Feb 15 12:06:31 rivo sudo[16799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 15 12:06:31 rivo sudo[16799]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:31 rivo volumio[3274]: info: Output device has changed, restarting Shairport Sync
Feb 15 12:06:31 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:31 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 15 12:06:31 rivo sudo[16799]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:31 rivo sudo[16802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 15 12:06:31 rivo sudo[16802]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:31 rivo volumio[3274]: No protocol specified
Feb 15 12:06:31 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:31 rivo volumio[3274]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 15 12:06:31 rivo volumio[3274]: No protocol specified
Feb 15 12:06:31 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:31 rivo volumio[3274]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 15 12:06:31 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:31 rivo volumio[3274]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes
Feb 15 12:06:31 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:31 rivo vtcs[3955]: [2025-02-15 12:06:31.956] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE
Feb 15 12:06:31 rivo vtcs[3955]: [2025-02-15 12:06:31.958] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected
Feb 15 12:06:31 rivo volumio[3274]: info: Done.
Feb 15 12:06:32 rivo sudo[16810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 15 12:06:32 rivo sudo[16810]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 15 12:06:32 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:32 rivo systemd[1]: Stopping Volumio Tidal Connect Service...
Feb 15 12:06:32 rivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Feb 15 12:06:32 rivo volumio[3274]: info: MPD Permissions set
Feb 15 12:06:32 rivo systemd[1]: vtcs.service: Succeeded.
Feb 15 12:06:32 rivo systemd[1]: Stopped Volumio Tidal Connect Service.
Feb 15 12:06:32 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:32 rivo sudo[16813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 15 12:06:32 rivo sudo[16813]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo sudo[16810]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Feb 15 12:06:32 rivo sudo[16813]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: Starting Shairport Sync
Feb 15 12:06:32 rivo sudo[16826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 15 12:06:32 rivo sudo[16826]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:32 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 15 12:06:32 rivo systemd[1]: shairport-sync.service: Succeeded.
Feb 15 12:06:32 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 15 12:06:32 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:32 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 15 12:06:32 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 15 12:06:32 rivo sudo[16826]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:32 rivo volumio[3274]: info: Shairport-Sync Started
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 15 12:06:32 rivo volumio[3274]: info: Not Reporting Auto name since its the default one
Feb 15 12:06:32 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Feb 15 12:06:32 rivo volumio[3274]: No protocol specified
Feb 15 12:06:32 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:32 rivo sudo[16846]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
Feb 15 12:06:32 rivo sudo[16846]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:32 rivo sudo[16846]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:32 rivo sudo[16848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Feb 15 12:06:32 rivo sudo[16848]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:32 rivo systemd[1]: Stopping RAAT DAEMON...
Feb 15 12:06:32 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
Feb 15 12:06:32 rivo systemd[1]: raat-daemon.service: Succeeded.
Feb 15 12:06:32 rivo systemd[1]: Stopped RAAT DAEMON.
Feb 15 12:06:32 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:32 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 15 12:06:32 rivo systemd[1]: Started RAAT DAEMON.
Feb 15 12:06:32 rivo sudo[16848]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:32 rivo volumio[3274]: info: Raat Daemon started successfully
Feb 15 12:06:32 rivo volumio[3274]: info: Enabling MyMusic plugin multiroom
Feb 15 12:06:32 rivo volumio[3274]: info: Enabling plugin multiroom
Feb 15 12:06:32 rivo volumio[3274]: info: Loading plugin "multiroom"...
Feb 15 12:06:32 rivo volumio[3274]: info: Applying required configuration parameters for plugin multiroom
Feb 15 12:06:32 rivo sudo[16858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Feb 15 12:06:32 rivo sudo[16858]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:32 rivo sudo[16858]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:32 rivo volumio[3274]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists
Feb 15 12:06:32 rivo volumio[3274]: info: MRS: MultiRoom plugin initialized
Feb 15 12:06:32 rivo volumio[3274]: info: MRS: STOPPING SNAPCLIENT
Feb 15 12:06:33 rivo volumio[3274]: info: MRS: Snap server stop
Feb 15 12:06:33 rivo sudo[16876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Feb 15 12:06:33 rivo volumio[3274]: info: MRS: STOPPING volumioStreaming
Feb 15 12:06:33 rivo sudo[16876]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:33 rivo sudo[16878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Feb 15 12:06:33 rivo sudo[16878]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:33 rivo sudo[16876]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:33 rivo sudo[16882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Feb 15 12:06:33 rivo sudo[16882]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:33 rivo sudo[16878]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:33 rivo volumio[3274]: info: Preparing to generate the ALSA configuration file
Feb 15 12:06:33 rivo sudo[16882]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:33 rivo sudo[16886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Feb 15 12:06:33 rivo sudo[16886]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:33 rivo sudo[16886]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:33 rivo sudo[16890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Feb 15 12:06:33 rivo sudo[16890]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:33 rivo volumio[3274]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Feb 15 12:06:33 rivo volumio[3274]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Feb 15 12:06:33 rivo volumio[3274]: info: Reading ALSA contributions from plugins.
Feb 15 12:06:33 rivo volumio[3274]: info: MRS: Removed streaming files
Feb 15 12:06:33 rivo volumio[3274]: info: MRS: volumioStreaming STOPPED
Feb 15 12:06:33 rivo volumio[3274]: info: MRS: SNAPSERVER STOPPED
Feb 15 12:06:33 rivo volumio[3274]: info: MRS: SNAPCLIENT STOPPED
Feb 15 12:06:33 rivo systemd[1]: Started Volumio Bluetooth Module.
Feb 15 12:06:33 rivo sudo[16890]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:33 rivo volumio[3274]: info: Volumio BT Module successfully started
Feb 15 12:06:33 rivo volumio[3274]: info: Asound.conf file written
Feb 15 12:06:33 rivo sudo[16893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Feb 15 12:06:33 rivo sudo[16893]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:33 rivo volumiobt[16892]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
Feb 15 12:06:33 rivo sudo[16893]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:33 rivo sudo[16897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Feb 15 12:06:33 rivo sudo[16897]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:33 rivo sudo[16897]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:33 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994
Feb 15 12:06:33 rivo kernel: Err: can not set rate to 4274967296!
Feb 15 12:06:33 rivo kernel: Range[3920000 - 500000000]
Feb 15 12:06:33 rivo kernel: out of value, fixed it
Feb 15 12:06:33 rivo kernel: id=0 set inskew=0
Feb 15 12:06:33 rivo volumio[3274]: No protocol specified
Feb 15 12:06:33 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:33 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted
Feb 15 12:06:33 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted
Feb 15 12:06:33 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted
Feb 15 12:06:33 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted
Feb 15 12:06:33 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Topping Internal Clock Validity:0' : Operation not permitted
Feb 15 12:06:33 rivo volumio[3274]: info: Output device has changed, restarting MPD
Feb 15 12:06:33 rivo sudo[16902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 15 12:06:33 rivo sudo[16902]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:33 rivo volumio[3274]: info: Output device has changed, restarting Shairport Sync
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 15 12:06:33 rivo sudo[16902]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:33 rivo sudo[16905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 15 12:06:33 rivo sudo[16905]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:33 rivo volumio[3274]: No protocol specified
Feb 15 12:06:33 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:33 rivo volumio[3274]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 15 12:06:33 rivo volumio[3274]: No protocol specified
Feb 15 12:06:33 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:33 rivo volumio[3274]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo sudo[16914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 15 12:06:33 rivo sudo[16914]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:33 rivo volumio[3274]: info: PLUGIN START: multiroom
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Feb 15 12:06:33 rivo volumio[3274]: info: MRS: Pushing multiroomSync output for this device
Feb 15 12:06:33 rivo volumio[3274]: info: MRS: Pushing multiroomSync output
Feb 15 12:06:33 rivo volumio[3274]: info: Adding audio output:
Feb 15 12:06:33 rivo sudo[16914]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:33 rivo volumio[3274]: error: Can't add:
Feb 15 12:06:33 rivo volumio[3274]: info: Adding audio output:
Feb 15 12:06:33 rivo volumio[3274]: error: Can't add:
Feb 15 12:06:33 rivo volumio[3274]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:33 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:33 rivo sudo[16925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 15 12:06:33 rivo sudo[16925]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:33 rivo volumio[3274]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Feb 15 12:06:33 rivo volumio[3274]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Feb 15 12:06:33 rivo volumio[3274]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Feb 15 12:06:33 rivo volumio[3274]: info: MPD Permissions set
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo sudo[16925]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Feb 15 12:06:33 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:33 rivo volumio[3274]: info: Starting Shairport Sync
Feb 15 12:06:34 rivo volumio[3274]: info: Preparing to generate the ALSA configuration file
Feb 15 12:06:34 rivo sudo[16935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 15 12:06:34 rivo sudo[16935]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:34 rivo volumio[3274]: info: Done.
Feb 15 12:06:34 rivo volumio[3274]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Feb 15 12:06:34 rivo volumio[3274]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Feb 15 12:06:34 rivo volumio[3274]: info: Reading ALSA contributions from plugins.
Feb 15 12:06:34 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 15 12:06:34 rivo systemd[1]: shairport-sync.service: Succeeded.
Feb 15 12:06:34 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 15 12:06:34 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 15 12:06:34 rivo sudo[16935]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:34 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:34 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 15 12:06:34 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:34 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 15 12:06:34 rivo volumio[3274]: info: Executing endpoint restartRAATSocket
Feb 15 12:06:34 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Feb 15 12:06:34 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:34 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 15 12:06:34 rivo volumio[3274]: info: Not Reporting Auto name since its the default one
Feb 15 12:06:34 rivo volumio[3274]: info: Disabling MyMusic plugin upnp
Feb 15 12:06:34 rivo volumio[3274]: info: Shairport-Sync Started
Feb 15 12:06:34 rivo sudo[16953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Feb 15 12:06:34 rivo sudo[16953]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:34 rivo volumio[3274]: info: CorePlayQueue::getTrack 9
Feb 15 12:06:34 rivo volumio[3274]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
Feb 15 12:06:34 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Feb 15 12:06:34 rivo systemd[1]: Stopping UPnP Renderer front-end to MPD...
Feb 15 12:06:34 rivo volumio[3274]: No protocol specified
Feb 15 12:06:34 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:34 rivo sudo[16957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Feb 15 12:06:34 rivo sudo[16957]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:34 rivo volumiobt[16892]: pulseaudio: no process found
Feb 15 12:06:34 rivo sudo[16957]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:34 rivo sudo[16960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
Feb 15 12:06:34 rivo sudo[16960]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:34 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:34 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:34 rivo volumio[3274]: error: Upnp client error: Error: This socket has been ended by the other party
Feb 15 12:06:34 rivo sudo[16960]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:34 rivo volumio[3274]: info: Asound.conf file written
Feb 15 12:06:34 rivo sudo[16963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Feb 15 12:06:34 rivo sudo[16963]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:34 rivo sudo[16967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Feb 15 12:06:34 rivo sudo[16967]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:34 rivo sudo[16967]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:34 rivo systemd[1]: Stopping RAAT DAEMON...
Feb 15 12:06:34 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
Feb 15 12:06:34 rivo systemd[1]: raat-daemon.service: Succeeded.
Feb 15 12:06:34 rivo systemd[1]: Stopped RAAT DAEMON.
Feb 15 12:06:34 rivo systemd[1]: Started RAAT DAEMON.
Feb 15 12:06:34 rivo sudo[16963]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:34 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994
Feb 15 12:06:34 rivo kernel: Err: can not set rate to 4270967296!
Feb 15 12:06:34 rivo kernel: Range[3920000 - 500000000]
Feb 15 12:06:34 rivo kernel: out of value, fixed it
Feb 15 12:06:34 rivo kernel: id=0 set inskew=0
Feb 15 12:06:34 rivo volumio[3274]: No protocol specified
Feb 15 12:06:34 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:34 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted
Feb 15 12:06:34 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted
Feb 15 12:06:34 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted
Feb 15 12:06:34 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted
Feb 15 12:06:34 rivo volumio[3274]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Topping Internal Clock Validity:0' : Operation not permitted
Feb 15 12:06:34 rivo volumio[3274]: info: Output device has changed, restarting MPD
Feb 15 12:06:34 rivo sudo[16978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 15 12:06:34 rivo sudo[16978]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:34 rivo volumio[3274]: info: Output device has changed, restarting Shairport Sync
Feb 15 12:06:34 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:34 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 15 12:06:34 rivo sudo[16978]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:34 rivo sudo[16982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 15 12:06:34 rivo sudo[16982]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:34 rivo volumio[3274]: No protocol specified
Feb 15 12:06:34 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:34 rivo volumio[3274]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 15 12:06:34 rivo volumio[3274]: No protocol specified
Feb 15 12:06:34 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:34 rivo volumio[3274]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 15 12:06:34 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:34 rivo volumio[3274]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes
Feb 15 12:06:34 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:34 rivo pulseaudio[16965]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Feb 15 12:06:34 rivo pulseaudio[16965]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Feb 15 12:06:34 rivo volumiobt[16892]: Applying permissions
Feb 15 12:06:34 rivo volumiobt[16892]: Setting BT discoverable and pairable
Feb 15 12:06:34 rivo bluetoothd[3201]: Endpoint registered: sender=:1.70 path=/MediaEndpoint/A2DPSource
Feb 15 12:06:34 rivo bluetoothd[3201]: Endpoint registered: sender=:1.70 path=/MediaEndpoint/A2DPSink
Feb 15 12:06:34 rivo volumio[3274]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 15 12:06:34 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:34 rivo pulseaudio[16965]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files
Feb 15 12:06:34 rivo sudo[16994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 15 12:06:34 rivo sudo[16994]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:34 rivo volumio[3274]: info: Preparing to generate the ALSA configuration file
Feb 15 12:06:34 rivo volumiobt[16892]: Agent registered
Feb 15 12:06:34 rivo volumiobt[16892]: [bluetooth]# -e power on
Feb 15 12:06:34 rivo volumiobt[16892]: Invalid command in menu main: -e
Feb 15 12:06:34 rivo volumiobt[16892]:
Feb 15 12:06:34 rivo volumiobt[16892]: Use "help" for a list of available commands in a menu.
Feb 15 12:06:34 rivo volumiobt[16892]: Use "menu " if you want to enter any submenu.
Feb 15 12:06:34 rivo volumiobt[16892]: Use "back" if you want to return to menu main.
Feb 15 12:06:34 rivo volumiobt[16892]: [bluetooth]# agent on
Feb 15 12:06:34 rivo volumiobt[16892]: Agent is already registered
Feb 15 12:06:34 rivo volumiobt[16892]: [bluetooth]# discoverable on
Feb 15 12:06:34 rivo volumiobt[16892]: [bluetooth]# pairable on
Feb 15 12:06:34 rivo volumiobt[16892]: [bluetooth]# agent NoInputNoOutput
Feb 15 12:06:34 rivo volumiobt[16892]: Agent is already registered
Feb 15 12:06:34 rivo volumiobt[16892]: [bluetooth]# default-agent
Feb 15 12:06:34 rivo volumiobt[16892]: [bluetooth]# quit
Feb 15 12:06:34 rivo volumiobt[16892]: [59B blob data]
Feb 15 12:06:34 rivo sudo[16994]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:34 rivo volumio[3274]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Feb 15 12:06:34 rivo volumio[3274]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Feb 15 12:06:34 rivo sudo[17001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 15 12:06:34 rivo volumio[3274]: info: Reading ALSA contributions from plugins.
Feb 15 12:06:34 rivo sudo[17001]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:35 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:35 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 15 12:06:35 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:35 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:35 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 15 12:06:35 rivo sudo[17001]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:35 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:35 rivo volumio[3274]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Feb 15 12:06:35 rivo volumio[3274]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Feb 15 12:06:35 rivo volumio[3274]: info: MPD Permissions set
Feb 15 12:06:35 rivo volumio[3274]: info: Raat Daemon started successfully
Feb 15 12:06:35 rivo volumio[3274]: info: TidalConnect service stoped!
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: TidalConnect service stoped!
Feb 15 12:06:35 rivo volumio[3274]: info: Starting Shairport Sync
Feb 15 12:06:35 rivo sudo[17016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 15 12:06:35 rivo sudo[17016]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:35 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 15 12:06:35 rivo systemd[1]: shairport-sync.service: Succeeded.
Feb 15 12:06:35 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 15 12:06:35 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 15 12:06:35 rivo volumio[3274]: info: Not Reporting Auto name since its the default one
Feb 15 12:06:35 rivo volumio[3274]: info: Asound.conf file unchanged, so no further update is needed
Feb 15 12:06:35 rivo volumio[3274]: info: Output device has changed, restarting MPD
Feb 15 12:06:35 rivo sudo[17016]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:35 rivo sudo[17029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 15 12:06:35 rivo volumio[3274]: info: Output device has changed, restarting Shairport Sync
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo sudo[17029]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 15 12:06:35 rivo sudo[17029]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:35 rivo sudo[17034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 15 12:06:35 rivo sudo[17034]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:35 rivo volumio[3274]: No protocol specified
Feb 15 12:06:35 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:35 rivo volumio[3274]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 15 12:06:35 rivo volumio[3274]: No protocol specified
Feb 15 12:06:35 rivo volumio[3274]: xcb_connection_has_error() returned true
Feb 15 12:06:35 rivo volumio[3274]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo volumio[3274]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 15 12:06:35 rivo sudo[17042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 15 12:06:35 rivo sudo[17042]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:35 rivo volumio[3274]: info: Preparing to generate the ALSA configuration file
Feb 15 12:06:35 rivo sudo[17042]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:35 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:35 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 15 12:06:35 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:35 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:35 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Feb 15 12:06:35 rivo sudo[17049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 15 12:06:35 rivo sudo[17049]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:35 rivo volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running
Feb 15 12:06:35 rivo volumio[3274]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Feb 15 12:06:35 rivo volumio[3274]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Feb 15 12:06:35 rivo sudo[17049]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:35 rivo volumio[3274]: info: RAAT: Requesting Headphone Status
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus
Feb 15 12:06:35 rivo volumio[3274]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Feb 15 12:06:35 rivo volumio[3274]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Feb 15 12:06:35 rivo volumio[3274]: info: Reading ALSA contributions from plugins.
Feb 15 12:06:35 rivo volumio[3274]: info: Enabling MyMusic plugin upnp
Feb 15 12:06:35 rivo volumio[3274]: info: Enabling plugin upnp
Feb 15 12:06:35 rivo volumio[3274]: info: Loading plugin "upnp"...
Feb 15 12:06:35 rivo volumio[3274]: info: [1739617595809] Starting Upmpd Daemon
Feb 15 12:06:35 rivo volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 15 12:06:35 rivo volumio[3274]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 15 12:06:35 rivo sudo[17053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Feb 15 12:06:35 rivo sudo[17053]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 12:06:35 rivo volumio[3274]: Error: listen EADDRINUSE: address already in use :::6599
Feb 15 12:06:35 rivo volumio[3274]: at Server.setupListenHandle [as _listen2] (net.js:1331:16)
Feb 15 12:06:35 rivo volumio[3274]: at listenInCluster (net.js:1379:12)
Feb 15 12:06:35 rivo volumio[3274]: at Server.listen (net.js:1465:7)
Feb 15 12:06:35 rivo volumio[3274]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
Feb 15 12:06:35 rivo volumio[3274]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
Feb 15 12:06:35 rivo volumio[3274]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Feb 15 12:06:35 rivo volumio[3274]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Feb 15 12:06:35 rivo volumio[3274]: at processTicksAndRejections (internal/process/task_queues.js:77:11) {
Feb 15 12:06:35 rivo volumio[3274]: code: 'EADDRINUSE',
Feb 15 12:06:35 rivo volumio[3274]: errno: -98,
Feb 15 12:06:35 rivo volumio[3274]: syscall: 'listen',
Feb 15 12:06:35 rivo volumio[3274]: address: '::',
Feb 15 12:06:35 rivo volumio[3274]: port: 6599
Feb 15 12:06:35 rivo volumio[3274]: }
Feb 15 12:06:35 rivo volumio[3274]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 15 12:06:35 rivo systemd[1]: Started Volumio Tidal Connect Service.
Feb 15 12:06:35 rivo sudo[17053]: pam_unix(sudo:session): session closed for user root
Feb 15 12:06:36 rivo sudo[17091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-15 12:05
Feb 15 12:06:36 rivo sudo[17091]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivo"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 05:04:03 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Rivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo"
VOLUMIO_HASH="b3e66dc85ea2c87aca7db72b97d00dff"