-- Logs begin at Mon 2026-01-26 23:31:34 EST, end at Wed 2026-01-28 01:55:58 EST. --
Jan 28 01:54:05 dolores volumio[3098]: info: CorePlayQueue::getTrack 1005
Jan 28 01:54:05 dolores volumio[3098]: info: CorePlayQueue::getTrack 1006
Jan 28 01:54:06 dolores go-librespot[3567]: time="2026-01-28T01:54:06-05:00" level=trace msg="sent dealer ping"
Jan 28 01:54:06 dolores go-librespot[3567]: time="2026-01-28T01:54:06-05:00" level=trace msg="received dealer pong"
Jan 28 01:54:11 dolores kernel: asoc-aml-card auge_sound: tdm playback stop
Jan 28 01:54:11 dolores kernel: spdif_a is set to disable
Jan 28 01:54:11 dolores kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3
Jan 28 01:54:11 dolores kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B
Jan 28 01:54:11 dolores kernel: tdm playback mute: 1, lane_cnt = 8
Jan 28 01:54:11 dolores kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1
Jan 28 01:54:11 dolores volumio[3098]: info:
Jan 28 01:54:11 dolores volumio[3098]: ---------------------------- MPD announces system playlist update
Jan 28 01:54:11 dolores volumio[3098]: info: Ignoring MPD Status Update
Jan 28 01:54:11 dolores volumio[3098]: info:
Jan 28 01:54:11 dolores volumio[3098]: ---------------------------- MPD announces state update: player
Jan 28 01:54:11 dolores volumio[3098]: info: ControllerMpd::getState
Jan 28 01:54:11 dolores volumio[3098]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 01:54:11 dolores volumio[3098]: info:
Jan 28 01:54:11 dolores volumio[3098]: ---------------------------- MPD announces system playlist update
Jan 28 01:54:11 dolores volumio[3098]: info: Ignoring MPD Status Update
Jan 28 01:54:11 dolores volumio[3098]: info:
Jan 28 01:54:11 dolores volumio[3098]: ---------------------------- MPD announces state update: player
Jan 28 01:54:11 dolores volumio[3098]: info: ControllerMpd::getState
Jan 28 01:54:11 dolores volumio[3098]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 01:54:11 dolores volumio[3098]: error: updateQueue error: null
Jan 28 01:54:11 dolores volumio[3098]: error: updateQueue error: null
Jan 28 01:54:11 dolores volumio[3098]: info: ------------------------------ 13ms
Jan 28 01:54:11 dolores volumio[3098]: info: sendMpdCommand status took 12 milliseconds
Jan 28 01:54:11 dolores volumio[3098]: info: ------------------------------ 11ms
Jan 28 01:54:11 dolores volumio[3098]: info: sendMpdCommand status took 3 milliseconds
Jan 28 01:54:11 dolores volumio[3098]: verbose: ControllerMpd::parseState
Jan 28 01:54:11 dolores volumio[3098]: verbose: ControllerMpd::parseState
Jan 28 01:54:11 dolores volumio[3098]: info: ControllerMpd::pushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::servicePushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::pushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::volumioPushState
Jan 28 01:54:11 dolores volumio[3098]: info: CorePlayQueue::getTrack 1005
Jan 28 01:54:11 dolores volumio[3098]: 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}
Jan 28 01:54:11 dolores volumio[3098]: verbose: CURRENT POSITION 1005
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::syncState stateService stop
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::syncState currentStatus play
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::volumioPushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::stPlaybackTimer
Jan 28 01:54:11 dolores volumio[3098]: info: ControllerMpd::pushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::servicePushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::pushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::volumioPushState
Jan 28 01:54:11 dolores volumio[3098]: info: CorePlayQueue::getTrack 0
Jan 28 01:54:11 dolores volumio[3098]: 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}
Jan 28 01:54:11 dolores volumio[3098]: verbose: CURRENT POSITION 0
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::syncState stateService stop
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::pushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::volumioPushState
Jan 28 01:54:11 dolores volumio[3098]: info: No code
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::pushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::volumioPushState
Jan 28 01:54:11 dolores volumio[3098]: info: ------------------------------ 44ms
Jan 28 01:54:11 dolores volumio[3098]: info: ------------------------------ 38ms
Jan 28 01:54:11 dolores volumio[3098]: info:
Jan 28 01:54:11 dolores volumio[3098]: ---------------------------- MPD announces system playlist update
Jan 28 01:54:11 dolores volumio[3098]: info: Ignoring MPD Status Update
Jan 28 01:54:11 dolores volumio[3098]: info:
Jan 28 01:54:11 dolores volumio[3098]: ---------------------------- MPD announces state update: player
Jan 28 01:54:11 dolores volumio[3098]: info: ControllerMpd::getState
Jan 28 01:54:11 dolores volumio[3098]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 01:54:11 dolores volumio[3098]: error: updateQueue error: null
Jan 28 01:54:11 dolores volumio[3098]: info: ------------------------------ 4ms
Jan 28 01:54:11 dolores volumio[3098]: info: sendMpdCommand status took 3 milliseconds
Jan 28 01:54:11 dolores volumio[3098]: verbose: ControllerMpd::parseState
Jan 28 01:54:11 dolores volumio[3098]: info: ControllerMpd::pushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::servicePushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::pushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::volumioPushState
Jan 28 01:54:11 dolores volumio[3098]: info: CorePlayQueue::getTrack 0
Jan 28 01:54:11 dolores volumio[3098]: 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}
Jan 28 01:54:11 dolores volumio[3098]: verbose: CURRENT POSITION 0
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::syncState stateService stop
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::syncState currentStatus stop
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::pushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::volumioPushState
Jan 28 01:54:11 dolores volumio[3098]: info: No code
Jan 28 01:54:11 dolores volumio[3098]: info: CoreStateMachine::pushState
Jan 28 01:54:11 dolores volumio[3098]: info: CoreCommandRouter::volumioPushState
Jan 28 01:54:11 dolores volumio[3098]: info: ------------------------------ 21ms
Jan 28 01:54:11 dolores volumio[3098]: info: Signalling Playback active due to playback status change
Jan 28 01:54:11 dolores volumio[3098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80
Jan 28 01:54:11 dolores volumio[3098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80
Jan 28 01:54:11 dolores volumio[3098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80
Jan 28 01:54:11 dolores volumio[3098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80
Jan 28 01:54:11 dolores volumio[3098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80
Jan 28 01:54:11 dolores volumio[3098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80
Jan 28 01:54:11 dolores volumio[3098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80
Jan 28 01:54:11 dolores volumio[3098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80
Jan 28 01:54:11 dolores volumio[3098]: info: MCU Signalled Playback Inactive
Jan 28 01:54:36 dolores go-librespot[3567]: time="2026-01-28T01:54:36-05:00" level=trace msg="sent dealer ping"
Jan 28 01:54:36 dolores go-librespot[3567]: time="2026-01-28T01:54:36-05:00" level=trace msg="received dealer pong"
Jan 28 01:54:55 dolores volumio5-onboarding[3837]: time=2026-01-28T01:54:55.738-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=73
Jan 28 01:54:56 dolores volumio5-onboarding[3837]: time=2026-01-28T01:54:56.079-05:00 level=WARN msg="received acknowledgment for source with no pending writes" component=conn/ble data=4900 addr=73
Jan 28 01:55:00 dolores dbus-daemon[2829]: [system] Rejected send message, 1 matched rules; type="error", sender=":1.15" (uid=0 pid=3837 comm="/usr/bin/volumio5-onboarding " label="kernel") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.5" (uid=0 pid=3186 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap,hostn" label="kernel")
Jan 28 01:55:00 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:00.746-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=73
Jan 28 01:55:01 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:01.047-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=73
Jan 28 01:55:01 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:01.347-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=73
Jan 28 01:55:01 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:01.648-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=73
Jan 28 01:55:01 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:01.949-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=73
Jan 28 01:55:02 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:02.250-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=73
Jan 28 01:55:02 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:02.551-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=73
Jan 28 01:55:02 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:02.853-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=73
Jan 28 01:55:03 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:03.154-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=73
Jan 28 01:55:03 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:03.455-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=73
Jan 28 01:55:03 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:03.755-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=73
Jan 28 01:55:03 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:03.755-05:00 level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=73 chunks=1 index=0
Jan 28 01:55:05 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:05.258-05:00 level=INFO msg="new address was allocated" component=conn/ble old=74 new=75
Jan 28 01:55:05 dolores dbus-daemon[2829]: [system] Rejected send message, 1 matched rules; type="error", sender=":1.15" (uid=0 pid=3837 comm="/usr/bin/volumio5-onboarding " label="kernel") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.5" (uid=0 pid=3186 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap,hostn" label="kernel")
Jan 28 01:55:06 dolores go-librespot[3567]: time="2026-01-28T01:55:06-05:00" level=trace msg="sent dealer ping"
Jan 28 01:55:06 dolores go-librespot[3567]: time="2026-01-28T01:55:06-05:00" level=trace msg="received dealer pong"
Jan 28 01:55:20 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:20.840-05:00 level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=74
Jan 28 01:55:20 dolores volumio5-onboarding[3837]: time=2026-01-28T01:55:20.986-05:00 level=WARN msg="received acknowledgment for source with no pending writes" component=conn/ble data=4a00 addr=74
Jan 28 01:55:36 dolores go-librespot[3567]: time="2026-01-28T01:55:36-05:00" level=trace msg="sent dealer ping"
Jan 28 01:55:36 dolores go-librespot[3567]: time="2026-01-28T01:55:36-05:00" level=trace msg="received dealer pong"
Jan 28 01:55:40 dolores nmbd[3050]: [2026/01/28 01:55:40.315810, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jan 28 01:55:40 dolores nmbd[3050]: query_name_response: Multiple (2) responses received for a query on subnet 10.0.0.253 for name WORKGROUP<1d>.
Jan 28 01:55:40 dolores nmbd[3050]: This response was from IP 10.0.0.1, reporting an IP address of 10.0.0.1.
Jan 28 01:55:44 dolores go-librespot[3567]: time="2026-01-28T01:55:44-05:00" level=trace msg="received accesspoint ping"
Jan 28 01:55:44 dolores go-librespot[3567]: time="2026-01-28T01:55:44-05:00" level=trace msg="received accesspoint pong ack"
Jan 28 01:55:48 dolores volumio[3098]: Searching plugin music_service/tidal
Jan 28 01:55:48 dolores volumio[3098]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Jan 28 01:55:48 dolores volumio[3098]: info: searchTIDALUri took 373 milliseconds
Jan 28 01:55:48 dolores volumio[3098]: info: search took 374 milliseconds
Jan 28 01:55:48 dolores volumio[3098]: info: All search sources collected, pushing search results
Jan 28 01:55:55 dolores volumio[3098]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
Jan 28 01:55:56 dolores volumio[3098]: info: browseTIDALUri took 1129 milliseconds
Jan 28 01:55:56 dolores volumio[3098]: info: Preload queue cleared
Jan 28 01:55:56 dolores volumio[3098]: info: Preload queue cleared
Jan 28 01:55:56 dolores volumio[3098]: info: Preload queue cleared
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/10649934
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/10649936
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/10649940
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/8298177
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/25064564
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800488
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/10649935
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800485
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/10649938
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800483
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800487
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/12309760
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/36975063
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/10649939
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/10649941
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/10649937
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800479
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/10649942
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800490
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800484
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/482772528
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/482768036
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/474870358
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/296902247
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/10649943
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/11957773
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/10073933
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/62188178
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/69863983
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800480
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/3367379
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/11957774
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/2386769
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800496
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/48440471
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800478
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/48462425
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/11957775
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800481
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/11957779
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800486
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/11957776
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/11957778
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800495
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/11957777
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/3367369
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/8298188
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/63800489
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/11957781
Jan 28 01:55:56 dolores volumio[3098]: info: Preloading song: tidal://song/11957780
Jan 28 01:55:56 dolores volumio[3098]: info: Exploding uri tidal://song/10649934 in service tidal
Jan 28 01:55:56 dolores volumio[3098]: info: Exploding uri tidal://song/10649936 in service tidal
Jan 28 01:55:56 dolores volumio[3098]: info: Exploding uri tidal://song/10649940 in service tidal
Jan 28 01:55:56 dolores volumio[3098]: info: Executing endpoint getSimilarArtists
Jan 28 01:55:56 dolores volumio[3098]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists
Jan 28 01:55:56 dolores volumio[3098]: info: Exploding uri tidal://song/8298177 in service tidal
Jan 28 01:55:56 dolores volumio[3098]: info: explodeTIDALUri took 164 milliseconds
Jan 28 01:55:56 dolores volumio[3098]: info: Executing endpoint getSimilarArtists
Jan 28 01:55:56 dolores volumio[3098]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists
Jan 28 01:55:56 dolores volumio[3098]: info: Exploding uri tidal://song/25064564 in service tidal
Jan 28 01:55:56 dolores volumio[3098]: info: explodeTIDALUri took 190 milliseconds
Jan 28 01:55:56 dolores volumio[3098]: info: Executing endpoint metavolumio
Jan 28 01:55:56 dolores volumio[3098]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jan 28 01:55:56 dolores volumio[3098]: info: Executing endpoint metavolumio
Jan 28 01:55:56 dolores volumio[3098]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jan 28 01:55:56 dolores volumio[3098]: info: Exploding uri tidal://song/63800488 in service tidal
Jan 28 01:55:56 dolores volumio[3098]: info: Exploding uri tidal://song/10649935 in service tidal
Jan 28 01:55:56 dolores volumio[3098]: info: explodeTIDALUri took 207 milliseconds
Jan 28 01:55:56 dolores volumio[3098]: info: Exploding uri tidal://song/63800485 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 208 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/10649938 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/63800483 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 288 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/63800487 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 247 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 230 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/12309760 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 212 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/36975063 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 146 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 227 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 136 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/10649939 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/10649941 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 176 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/10649937 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 168 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/63800479 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/10649942 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 197 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 161 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/63800490 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 202 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/63800484 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/482772528 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 189 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 198 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/482768036 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 172 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/474870358 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 161 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/296902247 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 165 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/10649943 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 171 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/11957773 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: info: explodeTIDALUri took 171 milliseconds
Jan 28 01:55:57 dolores volumio[3098]: info: Exploding uri tidal://song/10073933 in service tidal
Jan 28 01:55:57 dolores volumio[3098]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 28 01:55:57 dolores volumio[3098]: Error: connect ECONNREFUSED 158.69.210.98:443
Jan 28 01:55:57 dolores volumio[3098]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Jan 28 01:55:57 dolores volumio[3098]: errno: -111,
Jan 28 01:55:57 dolores volumio[3098]: code: 'ECONNREFUSED',
Jan 28 01:55:57 dolores volumio[3098]: syscall: 'connect',
Jan 28 01:55:57 dolores volumio[3098]: address: '158.69.210.98',
Jan 28 01:55:57 dolores volumio[3098]: port: 443
Jan 28 01:55:57 dolores volumio[3098]: }
Jan 28 01:55:57 dolores volumio[3098]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 28 01:55:58 dolores sudo[17707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-28 01:54
Jan 28 01:55:58 dolores sudo[17707]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="primo2rev2"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 07:52:21 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Primo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Primo"
VOLUMIO_HASH="060c5b31331b90c840ee52059a8e3db0"