-- Logs begin at Tue 2024-11-26 13:47:28 JST, end at Tue 2024-11-26 17:43:11 JST. --
Nov 26 17:42:02 primo volumio[3390]: info: CoreCommandRouter::servicePushState
Nov 26 17:42:02 primo volumio[3390]: info: CorePlayQueue::getTrack 0
Nov 26 17:42:02 primo volumio[3390]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received raat
Nov 26 17:42:02 primo volumio[3390]: info: CoreCommandRouter::volumioPause
Nov 26 17:42:02 primo volumio[3390]: info: CoreStateMachine::pause
Nov 26 17:42:03 primo volumio[3390]: info: CoreCommandRouter::volumioPause
Nov 26 17:42:03 primo volumio[3390]: info: CoreStateMachine::pause
Nov 26 17:42:05 primo volumio[3390]: info: CoreCommandRouter::servicePushState
Nov 26 17:42:05 primo volumio[3390]: info: CorePlayQueue::getTrack 0
Nov 26 17:42:05 primo volumio[3390]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received raat
Nov 26 17:42:08 primo volumio[3390]: info: CoreCommandRouter::servicePushState
Nov 26 17:42:08 primo volumio[3390]: info: CorePlayQueue::getTrack 0
Nov 26 17:42:08 primo volumio[3390]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received raat
Nov 26 17:42:08 primo volumio[3390]: info: CoreCommandRouter::servicePushState
Nov 26 17:42:08 primo volumio[3390]: info: CorePlayQueue::getTrack 0
Nov 26 17:42:08 primo volumio[3390]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received raat
Nov 26 17:42:13 primo kernel: asoc-aml-card auge_sound: tdm playback stop
Nov 26 17:42:13 primo kernel: spdif_a is set to disable
Nov 26 17:42:13 primo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3
Nov 26 17:42:13 primo kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B
Nov 26 17:42:13 primo kernel: tdm playback mute: 1, lane_cnt = 8
Nov 26 17:42:13 primo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1
Nov 26 17:42:14 primo volumio[3390]: info: CoreCommandRouter::servicePushState
Nov 26 17:42:14 primo volumio[3390]: info: CorePlayQueue::getTrack 0
Nov 26 17:42:14 primo volumio[3390]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received raat
Nov 26 17:42:16 primo volumio[3390]: verbose: New Socket.io Connection to 192.168.0.11 from 192.168.0.14 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 8
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::volumioGetState
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::volumioGetState
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Nov 26 17:42:16 primo volumio[3390]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Nov 26 17:42:16 primo volumio[3390]: info: Received Get System Info
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 26 17:42:16 primo volumio[3390]: info: Discovery: Getting this device information
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::volumioGetState
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::volumioGetState
Nov 26 17:42:16 primo volumio[3390]: info: Listing playlists
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::volumioGetQueue
Nov 26 17:42:16 primo volumio[3390]: info: CoreStateMachine::getQueue
Nov 26 17:42:16 primo volumio[3390]: info: CorePlayQueue::getQueue
Nov 26 17:42:16 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Nov 26 17:42:20 primo volumio[3390]: info: CoreCommandRouter::volumioGetState
Nov 26 17:42:20 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 26 17:42:20 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 26 17:42:20 primo volumio[3390]: info: Discovery: Getting this device information
Nov 26 17:42:20 primo volumio[3390]: info: CoreCommandRouter::volumioGetState
Nov 26 17:42:20 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 26 17:42:22 primo volumio[3390]: info: Executing endpoint metavolumio
Nov 26 17:42:22 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Nov 26 17:42:22 primo volumio[3390]: info: Executing endpoint metavolumio
Nov 26 17:42:22 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Nov 26 17:42:22 primo volumio[3390]: info: Executing endpoint metavolumio
Nov 26 17:42:22 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Nov 26 17:42:23 primo volumio[3390]: info: CoreCommandRouter::volumioNext
Nov 26 17:42:23 primo volumio[3390]: info: CoreStateMachine::next
Nov 26 17:42:23 primo volumio[3390]: info: ControllerMpd::next
Nov 26 17:42:23 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand next
Nov 26 17:42:23 primo volumio[3390]: info: sendMpdCommand next took 23 milliseconds
Nov 26 17:42:23 primo volumio[3390]: info:
Nov 26 17:42:23 primo volumio[3390]: ---------------------------- MPD announces state update: player
Nov 26 17:42:23 primo volumio[3390]: info: ControllerMpd::getState
Nov 26 17:42:23 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand status
Nov 26 17:42:23 primo volumio[3390]: info: sendMpdCommand status took 2 milliseconds
Nov 26 17:42:23 primo volumio[3390]: verbose: ControllerMpd::parseState
Nov 26 17:42:23 primo volumio[3390]: info: ControllerMpd::pushState
Nov 26 17:42:23 primo volumio[3390]: info: CoreCommandRouter::servicePushState
Nov 26 17:42:23 primo volumio[3390]: info: CoreStateMachine::pushState
Nov 26 17:42:23 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 26 17:42:23 primo volumio[3390]: info: CoreCommandRouter::volumioPushState
Nov 26 17:42:23 primo volumio[3390]: info: MRS: Pushing multiroomSync output update for this device
Nov 26 17:42:23 primo volumio[3390]: info: MRS: Pushing multiroomSync output
Nov 26 17:42:23 primo volumio[3390]: info: CorePlayQueue::getTrack 0
Nov 26 17:42:23 primo volumio[3390]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Nov 26 17:42:23 primo volumio[3390]: verbose: CURRENT POSITION 0
Nov 26 17:42:23 primo volumio[3390]: info: CoreStateMachine::syncState stateService stop
Nov 26 17:42:23 primo volumio[3390]: info: CoreStateMachine::syncState currentStatus stop
Nov 26 17:42:23 primo volumio[3390]: info: CoreStateMachine::pushState
Nov 26 17:42:23 primo volumio[3390]: info: CoreCommandRouter::volumioPushState
Nov 26 17:42:23 primo volumio[3390]: info: MRS: Pushing multiroomSync output update for this device
Nov 26 17:42:23 primo volumio[3390]: info: MRS: Pushing multiroomSync output
Nov 26 17:42:23 primo volumio[3390]: info: No code
Nov 26 17:42:23 primo volumio[3390]: info: CoreStateMachine::pushState
Nov 26 17:42:23 primo volumio[3390]: info: CoreCommandRouter::volumioPushState
Nov 26 17:42:23 primo volumio[3390]: info: MRS: Pushing multiroomSync output update for this device
Nov 26 17:42:23 primo volumio[3390]: info: MRS: Pushing multiroomSync output
Nov 26 17:42:23 primo volumio[3390]: info: ------------------------------ 39ms
Nov 26 17:42:23 primo volumio[3390]: info: Updating RAAT Signal Path
Nov 26 17:42:23 primo volumio[3390]: info: Updating RAAT Signal Path
Nov 26 17:42:23 primo volumio[3390]: info: Updating RAAT Signal Path
Nov 26 17:42:23 primo volumio[3390]: info: Signalling Playback active due to playback status change
Nov 26 17:42:23 primo volumio[3390]: info: Signalling Playback active due to playback status change
Nov 26 17:42:23 primo volumio[3390]: info: Signalling Playback active due to playback status change
Nov 26 17:42:27 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Nov 26 17:42:28 primo volumio[3390]: info: handleBrowseUri took 198 milliseconds
Nov 26 17:42:28 primo volumio[3390]: info: Preload queue cleared
Nov 26 17:42:28 primo volumio[3390]: info: Preload queue cleared
Nov 26 17:42:33 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Nov 26 17:42:33 primo volumio[3390]: info: handleBrowseUri took 511 milliseconds
Nov 26 17:42:33 primo volumio[3390]: info: Preload queue cleared
Nov 26 17:42:36 primo volumio[3390]: info: Preload queue cleared
Nov 26 17:42:36 primo volumio[3390]: info: CoreCommandRouter::volumioReplaceandPlayItems
Nov 26 17:42:36 primo volumio[3390]: info: CoreStateMachine::ClearQueue
Nov 26 17:42:36 primo volumio[3390]: info: CoreStateMachine::stop
Nov 26 17:42:37 primo volumio[3390]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 26 17:42:37 primo volumio[3390]: info: CorePlayQueue::clearPlayQueue
Nov 26 17:42:37 primo volumio[3390]: info: CorePlayQueue::saveQueue
Nov 26 17:42:37 primo volumio[3390]: info: CoreCommandRouter::volumioPushQueue
Nov 26 17:42:37 primo volumio[3390]: info: CoreStateMachine::addQueueItems
Nov 26 17:42:37 primo volumio[3390]: info: CorePlayQueue::addQueueItems
Nov 26 17:42:37 primo volumio[3390]: info: Preload queue cleared
Nov 26 17:42:37 primo volumio[3390]: info: Adding Item to queue: qobuz://album/0603497954902
Nov 26 17:42:37 primo volumio[3390]: info: Exploding uri qobuz://album/0603497954902 in service qobuz
Nov 26 17:42:37 primo volumio[3390]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Nov 26 17:42:37 primo volumio[3390]: info: explodeUri took 543 milliseconds
Nov 26 17:42:37 primo volumio[3390]: info: CoreCommandRouter::volumioPushQueue
Nov 26 17:42:37 primo volumio[3390]: info: CorePlayQueue::saveQueue
Nov 26 17:42:37 primo volumio[3390]: info: CoreStateMachine::updateTrackBlock
Nov 26 17:42:37 primo volumio[3390]: info: CorePlayQueue::getTrackBlock
Nov 26 17:42:37 primo volumio[3390]: info: CoreCommandRouter::volumioPlay
Nov 26 17:42:37 primo volumio[3390]: info: CoreStateMachine::play index 0
Nov 26 17:42:37 primo volumio[3390]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 26 17:42:37 primo volumio[3390]: info: CoreStateMachine::stop
Nov 26 17:42:37 primo volumio[3390]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 26 17:42:37 primo volumio[3390]: info: CoreStateMachine::play index undefined
Nov 26 17:42:37 primo volumio[3390]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 26 17:42:37 primo volumio[3390]: info: CorePlayQueue::getTrack 0
Nov 26 17:42:37 primo volumio[3390]: info: CoreStateMachine::startPlaybackTimer
Nov 26 17:42:37 primo volumio[3390]: info: CorePlayQueue::getTrack 0
Nov 26 17:42:37 primo volumio[3390]: info: [1732610557568] ControllerQobuz::clearAddPlayTrack
Nov 26 17:42:37 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand stop
Nov 26 17:42:37 primo volumio[3390]: info: sendMpdCommand stop took 5 milliseconds
Nov 26 17:42:37 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand clear
Nov 26 17:42:37 primo volumio[3390]: info:
Nov 26 17:42:37 primo volumio[3390]: ---------------------------- MPD announces system playlist update
Nov 26 17:42:37 primo volumio[3390]: info: Ignoring MPD Status Update
Nov 26 17:42:37 primo volumio[3390]: info: sendMpdCommand clear took 2 milliseconds
Nov 26 17:42:37 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/2881565"
Nov 26 17:42:37 primo volumio[3390]: STREAMING PROXY: Handling url /?data=qobuz://song/2881565
Nov 26 17:42:37 primo volumio[3390]: error: updateQueue error: null
Nov 26 17:42:37 primo volumio[3390]: info: ------------------------------ 8ms
Nov 26 17:42:37 primo volumio[3390]: info: Executing endpoint getStreamUrlqobuz
Nov 26 17:42:37 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Nov 26 17:42:38 primo volumio[3390]: info: getStreamUrl took 439 milliseconds
Nov 26 17:42:38 primo volumio[3390]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=2849934&eid=2881565&fmt=6&profile=raw&app_id=539451548&cid=2383804&etsp=1732614157&hmac=16-sgbMa2yrzco0BOwuAQaR7Qc0
Nov 26 17:42:39 primo volumio[3390]: STREAMING PROXY: Response: 200, length: 19542174
Nov 26 17:42:39 primo volumio[3390]: STREAMING PROXY: Client dropped request, destroying
Nov 26 17:42:39 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/2881565"
Nov 26 17:42:39 primo volumio[3390]: info:
Nov 26 17:42:39 primo volumio[3390]: ---------------------------- MPD announces system playlist update
Nov 26 17:42:39 primo volumio[3390]: info: Ignoring MPD Status Update
Nov 26 17:42:39 primo volumio[3390]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/2881565" took 2 milliseconds
Nov 26 17:42:39 primo volumio[3390]: info: CoreStateMachine::setConsumeUpdateService mpd
Nov 26 17:42:39 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand play
Nov 26 17:42:39 primo volumio[3390]: info: ------------------------------ 3ms
Nov 26 17:42:39 primo volumio[3390]: info: sendMpdCommand play took 2 milliseconds
Nov 26 17:42:39 primo volumio[3390]: STREAMING PROXY: Handling url /?data=qobuz://song/2881565
Nov 26 17:42:39 primo volumio[3390]: info: Executing endpoint getStreamUrlqobuz
Nov 26 17:42:39 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Nov 26 17:42:39 primo volumio[3390]: info: getStreamUrl took 454 milliseconds
Nov 26 17:42:39 primo volumio[3390]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=2849934&eid=2881565&fmt=6&profile=raw&app_id=539451548&cid=2383804&etsp=1732614159&hmac=pw2tP33_TJzym9X731zt08_F7D0
Nov 26 17:42:39 primo volumio[3390]: STREAMING PROXY: Response: 200, length: 19542174
Nov 26 17:42:39 primo volumio[3390]: info:
Nov 26 17:42:39 primo volumio[3390]: ---------------------------- MPD announces state update: player
Nov 26 17:42:39 primo volumio[3390]: info: ControllerMpd::getState
Nov 26 17:42:39 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand status
Nov 26 17:42:39 primo volumio[3390]: info:
Nov 26 17:42:39 primo volumio[3390]: ---------------------------- MPD announces state update: player
Nov 26 17:42:39 primo volumio[3390]: info: ControllerMpd::getState
Nov 26 17:42:39 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand status
Nov 26 17:42:39 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand clearerror
Nov 26 17:42:39 primo volumio[3390]: info: sendMpdCommand status took 12 milliseconds
Nov 26 17:42:39 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand clearerror
Nov 26 17:42:39 primo volumio[3390]: info: sendMpdCommand status took 12 milliseconds
Nov 26 17:42:39 primo volumio[3390]: verbose: ControllerMpd::parseState
Nov 26 17:42:39 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 26 17:42:39 primo volumio[3390]: verbose: ControllerMpd::parseState
Nov 26 17:42:39 primo volumio[3390]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 26 17:42:39 primo volumio[3390]: info: sendMpdCommand clearerror took 15 milliseconds
Nov 26 17:42:39 primo volumio[3390]: info: sendMpdCommand clearerror took 13 milliseconds
Nov 26 17:42:39 primo volumio[3390]: info: sendMpdCommand playlistinfo took 7 milliseconds
Nov 26 17:42:39 primo volumio[3390]: info: sendMpdCommand playlistinfo took 7 milliseconds
Nov 26 17:42:39 primo volumio[3390]: verbose: ControllerMpd::parseTrackInfo
Nov 26 17:42:39 primo volumio[3390]: verbose: ControllerMpd::parseTrackInfo
Nov 26 17:42:39 primo volumio[3390]: info: ControllerMpd::pushState
Nov 26 17:42:39 primo volumio[3390]: info: CoreCommandRouter::servicePushState
Nov 26 17:42:39 primo volumio[3390]: info: CorePlayQueue::getTrack 0
Nov 26 17:42:39 primo volumio[3390]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2881565","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/2881565","trackType":"qobuz"}
Nov 26 17:42:39 primo volumio[3390]: verbose: CURRENT POSITION 0
Nov 26 17:42:39 primo volumio[3390]: info: CoreStateMachine::syncState stateService pause
Nov 26 17:42:39 primo volumio[3390]: info: CoreStateMachine::syncState currentStatus stop
Nov 26 17:42:39 primo volumio[3390]: info: CoreStateMachine::pushState
Nov 26 17:42:39 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 26 17:42:39 primo volumio[3390]: info: CoreCommandRouter::volumioPushState
Nov 26 17:42:40 primo volumio[3390]: info: MRS: Pushing multiroomSync output update for this device
Nov 26 17:42:40 primo volumio[3390]: info: MRS: Pushing multiroomSync output
Nov 26 17:42:40 primo volumio[3390]: info: ControllerMpd::pushState
Nov 26 17:42:40 primo volumio[3390]: info: CoreCommandRouter::servicePushState
Nov 26 17:42:40 primo volumio[3390]: info: CorePlayQueue::getTrack 0
Nov 26 17:42:40 primo volumio[3390]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2881565","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/2881565","trackType":"qobuz"}
Nov 26 17:42:40 primo volumio[3390]: verbose: CURRENT POSITION 0
Nov 26 17:42:40 primo volumio[3390]: info: CoreStateMachine::syncState stateService pause
Nov 26 17:42:40 primo volumio[3390]: info: CoreStateMachine::syncState currentStatus stop
Nov 26 17:42:40 primo volumio[3390]: info: CoreStateMachine::pushState
Nov 26 17:42:40 primo volumio[3390]: info: CoreCommandRouter::volumioPushState
Nov 26 17:42:40 primo volumio[3390]: info: MRS: Pushing multiroomSync output update for this device
Nov 26 17:42:40 primo volumio[3390]: info: MRS: Pushing multiroomSync output
Nov 26 17:42:40 primo volumio[3390]: info: ------------------------------ 65ms
Nov 26 17:42:40 primo volumio[3390]: info: ------------------------------ 63ms
Nov 26 17:42:40 primo volumio[3390]: info: Updating RAAT Signal Path
Nov 26 17:42:40 primo volumio[3390]: info: Updating RAAT Signal Path
Nov 26 17:42:40 primo volumio[3390]: info: Signalling Playback active due to playback status change
Nov 26 17:42:40 primo volumio[3390]: info: Signalling Playback active due to playback status change
Nov 26 17:42:42 primo volumio[3390]: STREAMING PROXY: Client dropped request, destroying
Nov 26 17:42:50 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 26 17:42:50 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 26 17:42:50 primo volumio[3390]: info: Discovery: Getting this device information
Nov 26 17:42:50 primo volumio[3390]: info: CoreCommandRouter::volumioGetState
Nov 26 17:42:50 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 26 17:42:58 primo volumio[3390]: info: CoreCommandRouter::volumioGetState
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 26 17:43:00 primo volumio[3390]: info: Retrieving Cloud Streaming UI
Nov 26 17:43:00 primo volumio[3390]: info: Getting Tidal Cloud Configuration
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 26 17:43:00 primo volumio[3390]: info: Getting Qobuz Cloud Configuration
Nov 26 17:43:00 primo volumio[3390]: info: Asking plugin for UI Config
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 26 17:43:00 primo volumio[3390]: info: Getting Spotify Cloud Configuration
Nov 26 17:43:00 primo volumio[3390]: info: Asking plugin for UI Config
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 26 17:43:00 primo volumio[3390]: info: Saving Spotify Acccount
Nov 26 17:43:00 primo volumio[3390]: info: Got it
Nov 26 17:43:00 primo volumio[3390]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Nov 26 17:43:00 primo volumio[3390]: info: Got Tidal Cloud Configuration
Nov 26 17:43:00 primo volumio[3390]: info: Got it
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::volumioGetBrowseSources
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::volumioGetBrowseSources
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::volumioGetBrowseSources
Nov 26 17:43:00 primo volumio[3390]: info: Executing endpoint metavolumio
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Nov 26 17:43:00 primo volumio[3390]: info: Executing endpoint metavolumio
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Nov 26 17:43:00 primo volumio[3390]: info: Executing endpoint metavolumio
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 26 17:43:00 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Nov 26 17:43:04 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 26 17:43:05 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Nov 26 17:43:05 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Nov 26 17:43:08 primo volumio[3390]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Nov 26 17:43:10 primo volumio[3390]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 26 17:43:10 primo volumio[3390]: Error: dns service error: unknown
Nov 26 17:43:10 primo volumio[3390]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30)
Nov 26 17:43:10 primo volumio[3390]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
Nov 26 17:43:10 primo volumio[3390]: errorCode: -65537
Nov 26 17:43:10 primo volumio[3390]: }
Nov 26 17:43:10 primo volumio[3390]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 26 17:43:11 primo sudo[20890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 17:42
Nov 26 17:43:11 primo sudo[20890]: 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="primo2rev2"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 05:41:47 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Primo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Primo"
VOLUMIO_HASH="d050b972c82ad0b26840d04dc6ef55b1"