-- Logs begin at Mon 2024-12-23 10:39:49 HST, end at Thu 2025-02-27 18:19:34 HST. --
Feb 27 18:18:02 margules-magenta volumio[923]: info: Preload queue cleared
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreStateMachine::ClearQueue
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreStateMachine::stop
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 18:18:02 margules-magenta volumio[923]: info: CorePlayQueue::clearPlayQueue
Feb 27 18:18:02 margules-magenta volumio[923]: info: CorePlayQueue::saveQueue
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushQueue
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreStateMachine::addQueueItems
Feb 27 18:18:02 margules-magenta volumio[923]: info: CorePlayQueue::addQueueItems
Feb 27 18:18:02 margules-magenta volumio[923]: info: Preload queue cleared
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/176716601
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/176716601
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/176716596
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/176716596
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/176716603
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/176716603
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/170318995
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/170318995
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/170318994
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/170318994
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/74891023
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/74891023
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/74891025
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/74891025
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/7751025
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/7751025
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/143722966
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/143722966
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/143722970
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/143722970
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/54328845
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/54328845
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/227183377
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/227183377
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/96137479
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/96137479
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/96137872
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/96137872
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/170342703
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/170342703
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/170342702
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/170342702
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/94576816
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/94576816
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/94576813
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/94576813
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/267852739
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/267852739
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/170318998
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/170318998
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/170318991
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/170318991
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/170318999
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/170318999
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/25118132
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/25118132
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/25118129
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/25118129
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/74891020
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/74891020
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/281521407
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/281521407
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/217309466
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/217309466
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/106047577
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/106047577
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/72019203
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/72019203
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/72019200
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/72019200
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/46955988
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/46955988
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/46955994
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/46955994
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/115032748
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/115032748
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/25189580
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/25189580
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/254795208
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/254795208
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/193171338
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/193171338
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/193171340
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/193171340
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/123798438
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/123798438
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/74994128
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/74994128
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/47114
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/47114
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/170318990
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/170318990
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/298908634
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/298908634
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/127377621
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/127377621
Feb 27 18:18:02 margules-magenta volumio[923]: info: Adding Item to queue: qobuz://song/641946
Feb 27 18:18:02 margules-magenta volumio[923]: info: Using cached record of: qobuz://song/641946
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushQueue
Feb 27 18:18:02 margules-magenta volumio[923]: info: CorePlayQueue::saveQueue
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreStateMachine::updateTrackBlock
Feb 27 18:18:02 margules-magenta volumio[923]: info: CorePlayQueue::getTrackBlock
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPlay
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreStateMachine::play index 14
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreStateMachine::stop
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreStateMachine::play index undefined
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 18:18:02 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreStateMachine::startPlaybackTimer
Feb 27 18:18:02 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:02 margules-magenta volumio[923]: info: [1740716282142] ControllerQobuz::clearAddPlayTrack
Feb 27 18:18:02 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand stop
Feb 27 18:18:02 margules-magenta volumio[923]: info: sendMpdCommand stop took 4 milliseconds
Feb 27 18:18:02 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand clear
Feb 27 18:18:02 margules-magenta volumio[923]: info:
Feb 27 18:18:02 margules-magenta volumio[923]: ---------------------------- MPD announces system playlist update
Feb 27 18:18:02 margules-magenta volumio[923]: info: Ignoring MPD Status Update
Feb 27 18:18:02 margules-magenta volumio[923]: info: sendMpdCommand clear took 3 milliseconds
Feb 27 18:18:02 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/170342703"
Feb 27 18:18:02 margules-magenta volumio[923]: info:
Feb 27 18:18:02 margules-magenta volumio[923]: ---------------------------- MPD announces system playlist update
Feb 27 18:18:02 margules-magenta volumio[923]: info: Ignoring MPD Status Update
Feb 27 18:18:02 margules-magenta volumio[923]: info:
Feb 27 18:18:02 margules-magenta volumio[923]: ---------------------------- MPD announces system playlist update
Feb 27 18:18:02 margules-magenta volumio[923]: info: Ignoring MPD Status Update
Feb 27 18:18:02 margules-magenta volumio[923]: error: updateQueue error: null
Feb 27 18:18:02 margules-magenta volumio[923]: info: ------------------------------ 8ms
Feb 27 18:18:02 margules-magenta volumio[923]: error: Upnp client error: Error: This socket has been ended by the other party
Feb 27 18:18:02 margules-magenta volumio[923]: STREAMING PROXY: Handling url /?data=qobuz://song/170342703
Feb 27 18:18:02 margules-magenta volumio[923]: info: Executing endpoint getStreamUrlqobuz
Feb 27 18:18:02 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Feb 27 18:18:03 margules-magenta volumio[923]: info: getStreamUrl took 855 milliseconds
Feb 27 18:18:03 margules-magenta volumio[923]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=2563675&eid=170342703&fmt=7&profile=raw&app_id=539451548&cid=2540474&etsp=1740719882&hmac=GkUWLnHSnfLXZv2en7Cz-Vm-xok
Feb 27 18:18:03 margules-magenta wpa_supplicant[766]: wlan0: Failed to initiate sched scan
Feb 27 18:18:04 margules-magenta volumio[923]: STREAMING PROXY: Response: 200, length: 28062037
Feb 27 18:18:04 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/170342703"
Feb 27 18:18:04 margules-magenta volumio[923]: STREAMING PROXY: Client dropped request, destroying
Feb 27 18:18:04 margules-magenta volumio[923]: error: updateQueue error: null
Feb 27 18:18:04 margules-magenta volumio[923]: error: updateQueue error: null
Feb 27 18:18:04 margules-magenta volumio[923]: info:
Feb 27 18:18:04 margules-magenta volumio[923]: ---------------------------- MPD announces system playlist update
Feb 27 18:18:04 margules-magenta volumio[923]: info: Ignoring MPD Status Update
Feb 27 18:18:04 margules-magenta volumio[923]: info: ------------------------------ 2590ms
Feb 27 18:18:04 margules-magenta volumio[923]: info: ------------------------------ 2589ms
Feb 27 18:18:04 margules-magenta volumio[923]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/170342703" took 2 milliseconds
Feb 27 18:18:04 margules-magenta volumio[923]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 27 18:18:04 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand play
Feb 27 18:18:04 margules-magenta volumio[923]: info:
Feb 27 18:18:04 margules-magenta volumio[923]: ---------------------------- MPD announces system playlist update
Feb 27 18:18:04 margules-magenta volumio[923]: info: Ignoring MPD Status Update
Feb 27 18:18:04 margules-magenta volumio[923]: info:
Feb 27 18:18:04 margules-magenta volumio[923]: ---------------------------- MPD announces system playlist update
Feb 27 18:18:04 margules-magenta volumio[923]: info: Ignoring MPD Status Update
Feb 27 18:18:04 margules-magenta volumio[923]: info: ------------------------------ 6ms
Feb 27 18:18:04 margules-magenta volumio[923]: info: sendMpdCommand play took 5 milliseconds
Feb 27 18:18:04 margules-magenta volumio[923]: info: ------------------------------ 4ms
Feb 27 18:18:04 margules-magenta volumio[923]: info: ------------------------------ 3ms
Feb 27 18:18:04 margules-magenta volumio[923]: STREAMING PROXY: Handling url /?data=qobuz://song/170342703
Feb 27 18:18:04 margules-magenta volumio[923]: info: Executing endpoint getStreamUrlqobuz
Feb 27 18:18:04 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Feb 27 18:18:05 margules-magenta volumio[923]: info: getStreamUrl took 598 milliseconds
Feb 27 18:18:05 margules-magenta volumio[923]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=2563675&eid=170342703&fmt=7&profile=raw&app_id=539451548&cid=2540474&etsp=1740719885&hmac=EgI_jBnoRb4uaoFWXVgHA179BDI
Feb 27 18:18:05 margules-magenta volumio[923]: STREAMING PROXY: Response: 200, length: 28062037
Feb 27 18:18:05 margules-magenta volumio[923]: info:
Feb 27 18:18:05 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:18:05 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:18:05 margules-magenta volumio[923]: info:
Feb 27 18:18:05 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:18:05 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:18:05 margules-magenta volumio[923]: info:
Feb 27 18:18:05 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:18:05 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:18:05 margules-magenta volumio[923]: info: sendMpdCommand status took 12 milliseconds
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:18:05 margules-magenta volumio[923]: info:
Feb 27 18:18:05 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:18:05 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:18:05 margules-magenta volumio[923]: info: sendMpdCommand status took 13 milliseconds
Feb 27 18:18:05 margules-magenta volumio[923]: info: sendMpdCommand status took 12 milliseconds
Feb 27 18:18:05 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 27 18:18:05 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Feb 27 18:18:05 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:18:05 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus stop
Feb 27 18:18:05 margules-magenta volumio[923]: info: ------------------------------ 22ms
Feb 27 18:18:05 margules-magenta volumio[923]: info:
Feb 27 18:18:05 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:18:05 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:18:05 margules-magenta volumio[923]: info:
Feb 27 18:18:05 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:18:05 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:18:05 margules-magenta volumio[923]: info: sendMpdCommand status took 8 milliseconds
Feb 27 18:18:05 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 6 milliseconds
Feb 27 18:18:05 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 27 18:18:05 margules-magenta volumio[923]: info: sendMpdCommand status took 3 milliseconds
Feb 27 18:18:05 margules-magenta volumio[923]: info: sendMpdCommand status took 2 milliseconds
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:18:05 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus play
Feb 27 18:18:05 margules-magenta volumio[923]: info: Received an update from plugin. extracting info from payload
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:05 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus play
Feb 27 18:18:05 margules-magenta volumio[923]: info: Received an update from plugin. extracting info from payload
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:05 margules-magenta volumio[923]: info: ------------------------------ 51ms
Feb 27 18:18:05 margules-magenta volumio[923]: info: ------------------------------ 50ms
Feb 27 18:18:05 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 28 milliseconds
Feb 27 18:18:05 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 28 milliseconds
Feb 27 18:18:05 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 28 milliseconds
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:18:05 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus play
Feb 27 18:18:05 margules-magenta volumio[923]: info: Received an update from plugin. extracting info from payload
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:05 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus play
Feb 27 18:18:05 margules-magenta volumio[923]: info: Received an update from plugin. extracting info from payload
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:05 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:18:05 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus play
Feb 27 18:18:05 margules-magenta volumio[923]: info: Received an update from plugin. extracting info from payload
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:05 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:05 margules-magenta volumio[923]: info: ------------------------------ 73ms
Feb 27 18:18:05 margules-magenta volumio[923]: info: ------------------------------ 67ms
Feb 27 18:18:05 margules-magenta volumio[923]: info: ------------------------------ 66ms
Feb 27 18:18:07 margules-magenta volumio[923]: STREAMING PROXY: Client dropped request, destroying
Feb 27 18:18:12 margules-magenta wpa_supplicant[766]: wlan0: Failed to initiate sched scan
Feb 27 18:18:13 margules-magenta volumio[923]: info: VolumeController::SetAlsaVolume80
Feb 27 18:18:13 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:13 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 18:18:13 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:13 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:13 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:13 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Feb 27 18:18:13 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Feb 27 18:18:13 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
Feb 27 18:18:19 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 27 18:18:19 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 27 18:18:19 margules-magenta volumio[923]: info: Discovery: Getting this device information
Feb 27 18:18:19 margules-magenta volumio[923]: info: CoreCommandRouter::volumioGetState
Feb 27 18:18:19 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 27 18:18:21 margules-magenta wpa_supplicant[766]: wlan0: Failed to initiate sched scan
Feb 27 18:18:30 margules-magenta wpa_supplicant[766]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="Starlink-Hana"
Feb 27 18:18:30 margules-magenta wpa_supplicant[766]: wlan0: Trying to associate with SSID 'Starlink-Hana'
Feb 27 18:18:37 margules-magenta wpa_supplicant[766]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=36:bf:0d:28:6c:94 status_code=16
Feb 27 18:18:37 margules-magenta wpa_supplicant[766]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Starlink-Hana" auth_failures=6 duration=143 reason=CONN_FAILED
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::volumioSeek
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::seek
Feb 27 18:18:40 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:40 margules-magenta volumio[923]: info: TRACKBLOCK {"album":"Right For Me","albumUri":"qobuz://album/keho5691md8ja","albumart":"https://static.qobuz.com/images/covers/ja/d8/keho5691md8ja_600.jpg","artist":"The Teskey Brothers","artistUri":"qobuz://artist/4003728","audioQuality":"HI_RES","duration":251,"explicit":false,"name":"Baby Blue","service":"qobuz","title":"Baby Blue","tracknumber":2,"type":"track","uri":"qobuz://song/170342703","volumeNumber":1,"tagImage":"/albumart?sectionimage=music_service/qobuz/icons/qobuzhires.png"}
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::startPlaybackTimer
Feb 27 18:18:40 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:40 margules-magenta volumio[923]: info: [1740716320517] ControllerQobuz::seek
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 27 18:18:40 margules-magenta volumio[923]: info: ControllerMpd::seek
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:40 margules-magenta volumio[923]: error: null
Feb 27 18:18:40 margules-magenta volumio[923]: info:
Feb 27 18:18:40 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:18:40 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:18:40 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Feb 27 18:18:40 margules-magenta volumio[923]: info:
Feb 27 18:18:40 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:18:40 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:18:40 margules-magenta volumio[923]: info:
Feb 27 18:18:40 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:18:40 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:18:40 margules-magenta volumio[923]: info: sendMpdCommand status took 9 milliseconds
Feb 27 18:18:40 margules-magenta volumio[923]: info: sendMpdCommand status took 8 milliseconds
Feb 27 18:18:40 margules-magenta volumio[923]: info: sendMpdCommand status took 7 milliseconds
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:18:40 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 27 18:18:40 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 27 18:18:40 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 6 milliseconds
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:18:40 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"827 Kbps","isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus play
Feb 27 18:18:40 margules-magenta volumio[923]: info: Received an update from plugin. extracting info from payload
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:40 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"827 Kbps","isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus play
Feb 27 18:18:40 margules-magenta volumio[923]: info: Received an update from plugin. extracting info from payload
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:40 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"827 Kbps","isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:18:40 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus play
Feb 27 18:18:40 margules-magenta volumio[923]: info: Received an update from plugin. extracting info from payload
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:40 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:40 margules-magenta volumio[923]: info: ------------------------------ 60ms
Feb 27 18:18:40 margules-magenta volumio[923]: info: ------------------------------ 58ms
Feb 27 18:18:40 margules-magenta volumio[923]: info: ------------------------------ 58ms
Feb 27 18:18:49 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 27 18:18:49 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 27 18:18:49 margules-magenta volumio[923]: info: Discovery: Getting this device information
Feb 27 18:18:49 margules-magenta volumio[923]: info: CoreCommandRouter::volumioGetState
Feb 27 18:18:49 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 27 18:18:51 margules-magenta wpa_supplicant[766]: wlan0: Failed to initiate sched scan
Feb 27 18:18:53 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume
Feb 27 18:18:53 margules-magenta volumio[923]: info: Setting Remote Device Volume: http://192.168.1.57
Feb 27 18:18:53 margules-magenta volumio[923]: info:
Feb 27 18:18:53 margules-magenta volumio[923]: ---------------------------- Client requests Volume 7
Feb 27 18:18:53 margules-magenta volumio[923]: info: VolumeController::SetAlsaVolume7
Feb 27 18:18:53 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:18:53 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 18:18:53 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:18:53 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:18:53 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:18:53 margules-magenta volumio[923]: info: Done setting volume on:
Feb 27 18:18:53 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Feb 27 18:18:53 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Feb 27 18:18:53 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121
Feb 27 18:19:00 margules-magenta wpa_supplicant[766]: wlan0: Failed to initiate sched scan
Feb 27 18:19:05 margules-magenta sudo[1813]: pam_unix(sudo:session): session closed for user root
Feb 27 18:19:05 margules-magenta volumio[923]: info: Cannot mount NAS MyBackup at system boot, trial number 3 ,retrying in 5 seconds
Feb 27 18:19:07 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Feb 27 18:19:07 margules-magenta volumio[923]: info: Pausing Remote Device: http://192.168.1.57
Feb 27 18:19:07 margules-magenta volumio[923]: info:
Feb 27 18:19:07 margules-magenta volumio[923]: ---------------------------- Client requests Volumio pause
Feb 27 18:19:07 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPause
Feb 27 18:19:07 margules-magenta volumio[923]: info: CoreStateMachine::pause
Feb 27 18:19:07 margules-magenta volumio[923]: info: CoreStateMachine::stPlaybackTimer
Feb 27 18:19:07 margules-magenta volumio[923]: info: CoreStateMachine::servicePause
Feb 27 18:19:07 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:19:07 margules-magenta volumio[923]: info: CoreCommandRouter::servicePause
Feb 27 18:19:07 margules-magenta volumio[923]: info: [1740716347998] ControllerQobuz::pause
Feb 27 18:19:07 margules-magenta volumio[923]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 27 18:19:07 margules-magenta volumio[923]: info: ControllerMpd::pause
Feb 27 18:19:07 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand pause
Feb 27 18:19:08 margules-magenta volumio[923]: info:
Feb 27 18:19:08 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:19:08 margules-magenta volumio[923]: info: sendMpdCommand pause took 2 milliseconds
Feb 27 18:19:08 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:19:08 margules-magenta volumio[923]: info:
Feb 27 18:19:08 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:19:08 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:19:08 margules-magenta volumio[923]: info:
Feb 27 18:19:08 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:19:08 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:19:08 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:19:08 margules-magenta volumio[923]: info: sendMpdCommand status took 5 milliseconds
Feb 27 18:19:08 margules-magenta volumio[923]: info: sendMpdCommand status took 2 milliseconds
Feb 27 18:19:08 margules-magenta volumio[923]: info: sendMpdCommand status took 1 milliseconds
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:19:08 margules-magenta volumio[923]: info: Done pausing:
Feb 27 18:19:08 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 27 18:19:08 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 27 18:19:08 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:19:08 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:19:08 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":28857,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"713 Kbps","isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService pause
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus pause
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:19:08 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:19:08 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreStateMachine::stPlaybackTimer
Feb 27 18:19:08 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:19:08 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":28857,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"713 Kbps","isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService pause
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus pause
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:19:08 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:19:08 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreStateMachine::stPlaybackTimer
Feb 27 18:19:08 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:19:08 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":28857,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"713 Kbps","isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:19:08 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService pause
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus pause
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:19:08 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:19:08 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:19:08 margules-magenta volumio[923]: info: CoreStateMachine::stPlaybackTimer
Feb 27 18:19:08 margules-magenta volumio[923]: info: ------------------------------ 31ms
Feb 27 18:19:08 margules-magenta volumio[923]: info: ------------------------------ 29ms
Feb 27 18:19:08 margules-magenta volumio[923]: info: ------------------------------ 28ms
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Feb 27 18:19:09 margules-magenta volumio[923]: info: Playing Remote Device: http://192.168.1.57
Feb 27 18:19:09 margules-magenta volumio[923]: info:
Feb 27 18:19:09 margules-magenta volumio[923]: ---------------------------- Client requests Volumio play
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPlay
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::play index undefined
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 27 18:19:09 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::startPlaybackTimer
Feb 27 18:19:09 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:19:09 margules-magenta volumio[923]: info: [1740716349728] ControllerQobuz::resume
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 27 18:19:09 margules-magenta volumio[923]: info: ControllerMpd::resume
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand play
Feb 27 18:19:09 margules-magenta volumio[923]: info:
Feb 27 18:19:09 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:19:09 margules-magenta volumio[923]: info: sendMpdCommand play took 13 milliseconds
Feb 27 18:19:09 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:19:09 margules-magenta volumio[923]: info:
Feb 27 18:19:09 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:19:09 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:19:09 margules-magenta volumio[923]: info:
Feb 27 18:19:09 margules-magenta volumio[923]: ---------------------------- MPD announces state update: player
Feb 27 18:19:09 margules-magenta volumio[923]: info: ControllerMpd::getState
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 27 18:19:09 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Feb 27 18:19:09 margules-magenta kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121
Feb 27 18:19:09 margules-magenta volumio[923]: info: Done playing:
Feb 27 18:19:09 margules-magenta volumio[923]: info: sendMpdCommand status took 5 milliseconds
Feb 27 18:19:09 margules-magenta volumio[923]: info: sendMpdCommand status took 4 milliseconds
Feb 27 18:19:09 margules-magenta volumio[923]: info: sendMpdCommand status took 3 milliseconds
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::parseState
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 27 18:19:09 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 27 18:19:09 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 27 18:19:09 margules-magenta volumio[923]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 27 18:19:09 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29977,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"761 Kbps","isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus pause
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:19:09 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:19:09 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29977,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"761 Kbps","isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus play
Feb 27 18:19:09 margules-magenta volumio[923]: info: Received an update from plugin. extracting info from payload
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:19:09 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:19:09 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:19:09 margules-magenta volumio[923]: info: ControllerMpd::pushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreCommandRouter::servicePushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: CorePlayQueue::getTrack 14
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29977,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"761 Kbps","isStreaming":false,"title":"170342703","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170342703","trackType":"qobuz"}
Feb 27 18:19:09 margules-magenta volumio[923]: verbose: CURRENT POSITION 14
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::syncState currentStatus play
Feb 27 18:19:09 margules-magenta volumio[923]: info: Received an update from plugin. extracting info from payload
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:19:09 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreStateMachine::pushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 27 18:19:09 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output update for this device
Feb 27 18:19:09 margules-magenta volumio[923]: info: MRS: Pushing multiroomSync output
Feb 27 18:19:09 margules-magenta volumio[923]: info: ------------------------------ 40ms
Feb 27 18:19:09 margules-magenta volumio[923]: info: ------------------------------ 39ms
Feb 27 18:19:09 margules-magenta volumio[923]: info: ------------------------------ 38ms
Feb 27 18:19:10 margules-magenta sudo[2146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.110:/Public /mnt/NAS/MyBackup
Feb 27 18:19:10 margules-magenta sudo[2146]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 27 18:19:16 margules-magenta kernel: ieee80211 phy0: brcmf_escan_timeout: timer expired
Feb 27 18:19:16 margules-magenta wpa_supplicant[766]: wlan0: Failed to initiate sched scan
Feb 27 18:19:19 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 27 18:19:19 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 27 18:19:19 margules-magenta volumio[923]: info: Discovery: Getting this device information
Feb 27 18:19:19 margules-magenta volumio[923]: info: CoreCommandRouter::volumioGetState
Feb 27 18:19:19 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 27 18:19:25 margules-magenta wpa_supplicant[766]: wlan0: Failed to initiate sched scan
Feb 27 18:19:33 margules-magenta volumio[923]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay
Feb 27 18:19:33 margules-magenta volumio[923]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom
Feb 27 18:19:33 margules-magenta volumio[923]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 27 18:19:33 margules-magenta volumio[923]: TypeError: Cannot read property 'then' of undefined
Feb 27 18:19:33 margules-magenta volumio[923]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9)
Feb 27 18:19:33 margules-magenta volumio[923]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2249:30)
Feb 27 18:19:33 margules-magenta volumio[923]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1411:26)
Feb 27 18:19:33 margules-magenta volumio[923]: at Socket.emit (events.js:315:20)
Feb 27 18:19:33 margules-magenta volumio[923]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Feb 27 18:19:33 margules-magenta volumio[923]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Feb 27 18:19:33 margules-magenta volumio[923]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 27 18:19:34 margules-magenta wpa_supplicant[766]: wlan0: Failed to initiate sched scan
Feb 27 18:19:34 margules-magenta sudo[2215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-27 18:18
Feb 27 18:19:34 margules-magenta sudo[2215]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="margules"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 25 Mar 2024 12:05:08 PM CET"
VOLUMIO_VERSION="3.609"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_VENDOR_MODEL="Margules Magenta"
VOLUMIO_VENDOR="Margules"
VOLUMIO_MODEL="Margules Magenta"
VOLUMIO_HASH="1fe05d36c107355d439846423b3dc483"