May 25 22:01:13 dac ntpd[992]: CLOCK: time stepped by 3285347.901939
May 25 22:01:13 dac ntpd[992]: CLOCK: time changed from 2026-04-17 to 2026-05-25
May 25 22:01:13 dac ntpd[992]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes
May 25 22:01:13 dac volumio[1231]: info: Discovery: A device disappeared from network
May 25 22:01:13 dac volumio[1231]: info: Discovery: A device disappeared from network
May 25 22:01:16 dac volumio[1231]: info: Initializing connection to go-librespot Websocket
May 25 22:01:17 dac systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service...
May 25 22:01:17 dac systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems...
May 25 22:01:17 dac systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats.
May 25 22:01:17 dac systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
May 25 22:01:17 dac systemd[1]: e2scrub_all.service: Deactivated successfully.
May 25 22:01:17 dac systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems.
May 25 22:01:17 dac systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully.
May 25 22:01:17 dac systemd[1]: dpkg-db-backup.service: Deactivated successfully.
May 25 22:01:17 dac systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service.
May 25 22:01:18 dac systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3.
May 25 22:01:18 dac systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
May 25 22:01:18 dac systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
May 25 22:01:18 dac sudo[1659]: pam_unix(sudo:session): session closed for user root
May 25 22:01:20 dac volumio[1231]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask:
May 25 22:01:20 dac volumio[1231]: LoungeScreenDisconnected {
May 25 22:01:20 dac volumio[1231]: AID: null,
May 25 22:01:20 dac volumio[1231]: name: 'loungeScreenDisconnected',
May 25 22:01:20 dac volumio[1231]: payload: {}
May 25 22:01:20 dac volumio[1231]: }
May 25 22:01:20 dac volumio[1231]: (IncompleteAPIDataError) Missing data required to construct query string from bind params
May 25 22:01:20 dac volumio[1231]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] }
May 25 22:01:20 dac volumio[1231]: Stack trace:
May 25 22:01:20 dac volumio[1231]: IncompleteAPIDataError: Missing data required to construct query string from bind params
May 25 22:01:20 dac volumio[1231]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/BindParams.js:120:19)
May 25 22:01:20 dac volumio[1231]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:497:103)
May 25 22:01:20 dac volumio[1231]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:558:71)
May 25 22:01:20 dac volumio[1231]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/utils/AsyncTaskQueue.js:52:32)
May 25 22:01:20 dac volumio[1231]: at AsyncTaskQueue.push (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/utils/AsyncTaskQueue.js:39:23)
May 25 22:01:20 dac volumio[1231]: at /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:345:67
May 25 22:01:20 dac volumio[1231]: at new Promise ()
May 25 22:01:20 dac volumio[1231]: at Session.sendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:344:16)
May 25 22:01:20 dac volumio[1231]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:241:28)
May 25 22:01:20 dac volumio[1231]: at Session.begin (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:209:26)
May 25 22:01:20 dac volumio[1231]: at processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 22:01:20 dac volumio[1231]: at runNextTicks (node:internal/process/task_queues:64:3)
May 25 22:01:20 dac volumio[1231]: at process.processImmediate (node:internal/timers:449:9)
May 25 22:01:20 dac volumio[1231]: at async Promise.all (index 1)
May 25 22:01:20 dac volumio[1231]: at async YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/YouTubeApp.js:116:13)
May 25 22:01:20 dac volumio[1231]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/YouTubeCastReceiver.js:93:13)
May 25 22:01:20 dac volumio[1231]: error: [yt-cast-receiver] Failed to start receiver:
May 25 22:01:20 dac volumio[1231]: (AppError) Failed to start YouTubeApp
May 25 22:01:20 dac volumio[1231]: --->(SessionError) (YouTube Music) Failed to establish session
May 25 22:01:20 dac volumio[1231]: ------>(ConnectionError) (YouTube Music) Connection error in generating screen Id
May 25 22:01:20 dac volumio[1231]: Error info: {
May 25 22:01:20 dac volumio[1231]: url: 'https://www.youtube.com/api/lounge/pairing/generate_screen_id'
May 25 22:01:20 dac volumio[1231]: }
May 25 22:01:20 dac volumio[1231]: --------->(TypeError) fetch failed
May 25 22:01:20 dac volumio[1231]: Stack trace:
May 25 22:01:20 dac volumio[1231]: AppError: Failed to start YouTubeApp
May 25 22:01:20 dac volumio[1231]: at YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/YouTubeApp.js:133:19)
May 25 22:01:20 dac volumio[1231]: at processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 22:01:20 dac volumio[1231]: at runNextTicks (node:internal/process/task_queues:64:3)
May 25 22:01:20 dac volumio[1231]: at process.processImmediate (node:internal/timers:449:9)
May 25 22:01:20 dac volumio[1231]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/YouTubeCastReceiver.js:93:13)
May 25 22:01:20 dac volumio[1231]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask:
May 25 22:01:20 dac volumio[1231]: LoungeScreenDisconnected {
May 25 22:01:20 dac volumio[1231]: AID: null,
May 25 22:01:20 dac volumio[1231]: name: 'loungeScreenDisconnected',
May 25 22:01:20 dac volumio[1231]: payload: {}
May 25 22:01:20 dac volumio[1231]: }
May 25 22:01:20 dac volumio[1231]: (IncompleteAPIDataError) Missing data required to construct query string from bind params
May 25 22:01:20 dac volumio[1231]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] }
May 25 22:01:20 dac volumio[1231]: Stack trace:
May 25 22:01:20 dac volumio[1231]: IncompleteAPIDataError: Missing data required to construct query string from bind params
May 25 22:01:20 dac volumio[1231]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/BindParams.js:120:19)
May 25 22:01:20 dac volumio[1231]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:497:103)
May 25 22:01:20 dac volumio[1231]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:558:71)
May 25 22:01:20 dac volumio[1231]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/utils/AsyncTaskQueue.js:52:32)
May 25 22:01:20 dac volumio[1231]: at AsyncTaskQueue.push (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/utils/AsyncTaskQueue.js:39:23)
May 25 22:01:20 dac volumio[1231]: at /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:345:67
May 25 22:01:20 dac volumio[1231]: at new Promise ()
May 25 22:01:20 dac volumio[1231]: at Session.sendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:344:16)
May 25 22:01:20 dac volumio[1231]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:241:28)
May 25 22:01:20 dac volumio[1231]: at /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/YouTubeApp.js:125:39
May 25 22:01:20 dac volumio[1231]: at /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/YouTubeApp.js:130:19
May 25 22:01:20 dac volumio[1231]: at Array.forEach ()
May 25 22:01:20 dac volumio[1231]: at YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/YouTubeApp.js:120:24)
May 25 22:01:20 dac volumio[1231]: at processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 22:01:20 dac volumio[1231]: at runNextTicks (node:internal/process/task_queues:64:3)
May 25 22:01:20 dac volumio[1231]: at process.processImmediate (node:internal/timers:449:9)
May 25 22:01:20 dac volumio[1231]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask:
May 25 22:01:20 dac volumio[1231]: LoungeScreenDisconnected {
May 25 22:01:20 dac volumio[1231]: AID: null,
May 25 22:01:20 dac volumio[1231]: name: 'loungeScreenDisconnected',
May 25 22:01:20 dac volumio[1231]: payload: {}
May 25 22:01:20 dac volumio[1231]: }
May 25 22:01:20 dac volumio[1231]: (IncompleteAPIDataError) Missing data required to construct query string from bind params
May 25 22:01:20 dac volumio[1231]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] }
May 25 22:01:20 dac volumio[1231]: Stack trace:
May 25 22:01:20 dac volumio[1231]: IncompleteAPIDataError: Missing data required to construct query string from bind params
May 25 22:01:20 dac volumio[1231]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/BindParams.js:120:19)
May 25 22:01:20 dac volumio[1231]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:497:103)
May 25 22:01:20 dac volumio[1231]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:558:71)
May 25 22:01:20 dac volumio[1231]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/utils/AsyncTaskQueue.js:52:32)
May 25 22:01:20 dac volumio[1231]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:242:71)
May 25 22:01:20 dac volumio[1231]: at processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 22:01:20 dac volumio[1231]: at runNextTicks (node:internal/process/task_queues:64:3)
May 25 22:01:20 dac volumio[1231]: at process.processImmediate (node:internal/timers:449:9)
May 25 22:01:20 dac volumio[1231]: error: [ytcr] Failed to start plugin:
May 25 22:01:20 dac volumio[1231]: (AppError) Failed to start YouTubeApp
May 25 22:01:20 dac volumio[1231]: --->(SessionError) (YouTube Music) Failed to establish session
May 25 22:01:20 dac volumio[1231]: ------>(ConnectionError) (YouTube Music) Connection error in generating screen Id
May 25 22:01:20 dac volumio[1231]: Error info: {
May 25 22:01:20 dac volumio[1231]: url: 'https://www.youtube.com/api/lounge/pairing/generate_screen_id'
May 25 22:01:20 dac volumio[1231]: }
May 25 22:01:20 dac volumio[1231]: --------->(TypeError) fetch failed
May 25 22:01:20 dac volumio[1231]: Stack trace:
May 25 22:01:20 dac volumio[1231]: AppError: Failed to start YouTubeApp
May 25 22:01:20 dac volumio[1231]: at YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/YouTubeApp.js:133:19)
May 25 22:01:20 dac volumio[1231]: at processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 22:01:20 dac volumio[1231]: at runNextTicks (node:internal/process/task_queues:64:3)
May 25 22:01:20 dac volumio[1231]: at process.processImmediate (node:internal/timers:449:9)
May 25 22:01:20 dac volumio[1231]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/YouTubeCastReceiver.js:93:13)
May 25 22:01:20 dac volumio[1231]: info: Completed starting Core Plugins
May 25 22:01:20 dac volumio[1231]: info: -------------------------------------------
May 25 22:01:20 dac volumio[1231]: info: ----- MyVolumio plugins startup ----
May 25 22:01:20 dac volumio[1231]: info: -------------------------------------------
May 25 22:01:20 dac volumio[1231]: info: [MyVolumio PluginManager] Fetching plans data....
May 25 22:01:21 dac volumio[1231]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask:
May 25 22:01:21 dac volumio[1231]: LoungeScreenDisconnected {
May 25 22:01:21 dac volumio[1231]: AID: null,
May 25 22:01:21 dac volumio[1231]: name: 'loungeScreenDisconnected',
May 25 22:01:21 dac volumio[1231]: payload: {}
May 25 22:01:21 dac volumio[1231]: }
May 25 22:01:21 dac volumio[1231]: (IncompleteAPIDataError) Missing data required to construct query string from bind params
May 25 22:01:21 dac volumio[1231]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] }
May 25 22:01:21 dac volumio[1231]: Stack trace:
May 25 22:01:21 dac volumio[1231]: IncompleteAPIDataError: Missing data required to construct query string from bind params
May 25 22:01:21 dac volumio[1231]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/BindParams.js:120:19)
May 25 22:01:21 dac volumio[1231]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:497:103)
May 25 22:01:21 dac volumio[1231]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:558:71)
May 25 22:01:21 dac volumio[1231]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/utils/AsyncTaskQueue.js:52:32)
May 25 22:01:21 dac volumio[1231]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:242:71)
May 25 22:01:21 dac volumio[1231]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 22:01:21 dac volumio[1231]: at async /data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/YouTubeApp.js:125:25
May 25 22:01:21 dac volumio[1231]: info: Upmpdcli Daemon Started
May 25 22:01:21 dac volumio[1231]: info: Discovery: adding c8d40bd8-9f04-4527-9ec0-e68e86bbeb63
May 25 22:01:21 dac volumio[1231]: info: Discovery: Found device DAC
May 25 22:01:21 dac volumio[1231]: info: CoreCommandRouter::volumioGetState
May 25 22:01:21 dac volumio[1231]: info: CorePlayQueue::getTrack 0
May 25 22:01:22 dac volumio[1231]: SPOTIFY: User informations: {"country":"IN","display_name":"Songweaver","email":"songweaver84@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/51bwf5u2wn2rviu3th2f34lhg"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/51bwf5u2wn2rviu3th2f34lhg","id":"51bwf5u2wn2rviu3th2f34lhg","images":[],"product":"premium","type":"user","uri":"spotify:user:51bwf5u2wn2rviu3th2f34lhg"}
May 25 22:01:22 dac volumio[1231]: info: Spotify Successfully logged in
May 25 22:01:22 dac volumio[1231]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 25 22:01:22 dac volumio[1231]: info: [1779726682512] CoreMusicLibrary::Adding element Spotify
May 25 22:01:22 dac volumio[1231]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 25 22:01:22 dac volumio[1231]: Cannot find translation for source Mother Earth Radio
May 25 22:01:22 dac volumio[1231]: Cannot find translation for source Spotify
May 25 22:01:22 dac ntpd[992]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101
May 25 22:01:22 dac ntpd[992]: DNS: Pool taking: 192.46.215.60
May 25 22:01:22 dac ntpd[992]: DNS: Pool taking: 192.46.210.39
May 25 22:01:22 dac ntpd[992]: DNS: Pool taking: 139.84.142.141
May 25 22:01:22 dac ntpd[992]: DNS: Pool taking: 162.159.200.1
May 25 22:01:22 dac ntpd[992]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8
May 25 22:01:22 dac ntpd[992]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101
May 25 22:01:25 dac volumio[1231]: info: Discovery: this is already registered, c8d40bd8-9f04-4527-9ec0-e68e86bbeb63
May 25 22:01:25 dac volumio[1231]: info: Discovery: Found device DAC
May 25 22:01:25 dac volumio[1231]: info: CoreCommandRouter::volumioGetState
May 25 22:01:25 dac volumio[1231]: info: CorePlayQueue::getTrack 0
May 25 22:01:25 dac go-librespot[1606]: time="2026-05-25T22:01:25+05:30" level=debug msg="new websocket client"
May 25 22:01:26 dac volumio[1231]: info: Connection to go-librespot Websocket established
May 25 22:01:26 dac volumio[1231]: info: CoreCommandRouter::volumioGetState
May 25 22:01:26 dac volumio[1231]: info: CorePlayQueue::getTrack 0
May 25 22:01:28 dac ntpd[992]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101
May 25 22:01:28 dac ntpd[992]: DNS: Pool skipping: 192.46.210.39
May 25 22:01:28 dac ntpd[992]: DNS: Pool skipping: 95.216.192.15
May 25 22:01:28 dac ntpd[992]: DNS: Pool taking: 223.178.214.252
May 25 22:01:28 dac ntpd[992]: DNS: Pool skipping: 139.84.142.141
May 25 22:01:28 dac ntpd[992]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8
May 25 22:01:28 dac volumio[1231]: info: New access token = BQAtJCARjZYU94QACSBiCq17l_Pr2ak3ivJF3DUkWzk1QBoCmn1kwXVyzI_Q66A9sl33IQ4dprzlYuj-vCqyyVe9t4Anr9BU8Gu0NrLmYT_xI6AxMG2HyVkYtLXct18NdkZylzzlwd_QK85F-lq4Z8ezvSyBMpMflMvLCuAt-ahzceQNydbOmZr4avAMJ_4ZC1PJVn0XRVNL1xXegZd_lNzZiCjzoHWZod-PNerEamh3cmFJjUA89Lp1sA-9S08P-5TGTQSDVUGFCSc6be6mdbNIkZdZaQYa2hSjKMxsmseJ04cIBdmrIa_euw
May 25 22:01:28 dac volumio[1231]: info: New access token = BQBgRyXtqsyEKK80cd7O2q9YRWEjaJp9gGMeOk7d8iepuygxuZGBTSJSe0ADlnXCxy5Nzk9V0WXqR5VFYvgN3n4ldTMBUOU3r5o8uronucTPCunx8eXXFOspGM-eXv-jHnn4DN9g_23UamQJE-ZcaCHbesEW8Dg-6ETO7NZeeHt9PbmuZj5m56rBX4wVhsC6bBpdyOvsHfW8mbMRqHdykGuuM85yyu2FFB3KJXn6hVw7Gv6OYGx5vsMU5uQrRWP0lKHYQyYi7FVjwDpNjfEupcGJXjDxH8Ic1C9SghAf6CafkgiXn75wcSItVw
May 25 22:01:29 dac volumio[1231]: info: Getting Spotify volume
May 25 22:01:29 dac volumio[1231]: info: New access token = BQC30A-bqJpwKSjmV8zvRgAwEkBSGFbeBhos81FYGa_CRTyoaWvfBU-SOlwvMkU-bX0mafTnzESr3MBw87SN9tmfkZD3Z3Q_YDIVMdumTcMraJ5XUseA8TxpygPRl9bioK7D2gtdwukja8VpSL8bfo9v9nHKi4suHA7qOTKDTbe0avmWhAflMBGkDpYeubXI1HhEQmSZp09D33ROtJnfgqos_7Ltn3Tej5sQm8uHRSS9AFHa15_FHqvXmpXYtqRy2rRHC6tZAGJ-fjDFsQBjtXJqKLt5rOiblERvkAOipmnS-OIil7xQAgVSSw
May 25 22:01:30 dac volumio[1231]: error: [yt-cast-receiver] Caught error refreshing lounge token:
May 25 22:01:30 dac volumio[1231]: (TypeError) Cannot read properties of undefined (reading 'removeAllListeners')
May 25 22:01:30 dac volumio[1231]: TypeError: Cannot read properties of undefined (reading 'removeAllListeners')
May 25 22:01:30 dac volumio[1231]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:377:16)
May 25 22:01:30 dac volumio[1231]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 22:01:30 dac volumio[1231]: error: [yt-cast-receiver] Caught error refreshing lounge token:
May 25 22:01:30 dac volumio[1231]: (TypeError) Cannot read properties of undefined (reading 'removeAllListeners')
May 25 22:01:30 dac volumio[1231]: TypeError: Cannot read properties of undefined (reading 'removeAllListeners')
May 25 22:01:30 dac volumio[1231]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:377:16)
May 25 22:01:30 dac volumio[1231]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 22:01:30 dac volumio[1231]: error: [yt-cast-receiver] Caught error refreshing lounge token:
May 25 22:01:30 dac volumio[1231]: (TypeError) Cannot read properties of undefined (reading 'removeAllListeners')
May 25 22:01:30 dac volumio[1231]: TypeError: Cannot read properties of undefined (reading 'removeAllListeners')
May 25 22:01:30 dac volumio[1231]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:377:16)
May 25 22:01:30 dac volumio[1231]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 22:01:30 dac volumio[1231]: error: [yt-cast-receiver] Caught error refreshing lounge token:
May 25 22:01:30 dac volumio[1231]: (TypeError) Cannot read properties of undefined (reading 'removeAllListeners')
May 25 22:01:30 dac volumio[1231]: TypeError: Cannot read properties of undefined (reading 'removeAllListeners')
May 25 22:01:30 dac volumio[1231]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/Session.js:377:16)
May 25 22:01:30 dac volumio[1231]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 25 22:01:32 dac volumio[1231]: info: Volumio called home
May 25 22:01:33 dac volumio[1231]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
May 25 22:01:34 dac volumio[1231]: info: Discovery: this is already registered, c8d40bd8-9f04-4527-9ec0-e68e86bbeb63
May 25 22:01:34 dac volumio[1231]: info: Discovery: Found device DAC
May 25 22:01:34 dac volumio[1231]: info: CoreCommandRouter::volumioGetState
May 25 22:01:34 dac volumio[1231]: info: CorePlayQueue::getTrack 0
May 25 22:01:35 dac volumio[1231]: info: CoreCommandRouter::volumioGetState
May 25 22:01:35 dac volumio[1231]: info: CorePlayQueue::getTrack 0
May 25 22:01:35 dac volumio[1231]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93
May 25 22:01:35 dac volumio[1231]: SPOTIFY: SPOTIFY VOLUME undefined
May 25 22:01:35 dac volumio[1231]: SPOTIFY: VOLUMIO VOLUME 93
May 25 22:01:35 dac volumio[1231]: info: Aligning Spotify Volume to Volumio Volume
May 25 22:01:35 dac volumio[1231]: info: CoreCommandRouter::volumioGetState
May 25 22:01:35 dac volumio[1231]: info: CorePlayQueue::getTrack 0
May 25 22:01:35 dac volumio[1231]: info: Setting Spotify Volume from Volumio: 93
May 25 22:01:36 dac volumio[1231]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 25 22:01:36 dac volumio[1231]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 25 22:01:36 dac volumio[1231]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 25 22:01:36 dac volumio[1231]: SPOTIFY: SETTING SPOTIFY VOLUME 93
May 25 22:01:36 dac volumio[1231]: info: Sending Spotify command with payload to local API: /player/volume
May 25 22:01:37 dac go-librespot[1606]: time="2026-05-25T22:01:37+05:30" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy"
May 25 22:01:37 dac systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
May 25 22:01:37 dac volumio[1231]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up
May 25 22:01:37 dac volumio[1231]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 25 22:01:37 dac systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
May 25 22:01:37 dac volumio[1231]: Error: socket hang up
May 25 22:01:37 dac volumio[1231]: at connResetException (node:internal/errors:720:14)
May 25 22:01:37 dac volumio[1231]: at Socket.socketOnEnd (node:_http_client:519:23)
May 25 22:01:37 dac volumio[1231]: at Socket.emit (node:events:526:35)
May 25 22:01:37 dac volumio[1231]: at endReadableNT (node:internal/streams/readable:1376:12)
May 25 22:01:37 dac volumio[1231]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) {
May 25 22:01:37 dac volumio[1231]: code: 'ECONNRESET',
May 25 22:01:37 dac volumio[1231]: response: undefined
May 25 22:01:37 dac volumio[1231]: }
May 25 22:01:37 dac volumio[1231]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 25 22:01:38 dac volumio5-onboarding[1520]: failed to bootstrap state: failed to check for software update: could not check for updates: context deadline exceeded
May 25 22:01:38 dac systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE
May 25 22:01:38 dac systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'.
May 25 22:01:38 dac systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1.
May 25 22:01:38 dac systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server.
May 25 22:01:38 dac systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server.
May 25 22:01:38 dac volumio5-onboarding[1769]: time=2026-05-25T22:01:38.812+05:30 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z
May 25 22:01:39 dac upmpdcli[1776]: writing RSA key
May 25 22:01:40 dac systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1.
May 25 22:01:40 dac systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
May 25 22:01:40 dac systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
May 25 22:01:40 dac go-librespot[1782]: go-librespot daemon starting...
May 25 22:01:40 dac go-librespot[1783]: time="2026-05-25T22:01:40+05:30" level=info msg="running go-librespot 0.7.1"
May 25 22:01:40 dac go-librespot[1783]: time="2026-05-25T22:01:40+05:30" level=debug msg="app state loaded"
May 25 22:01:40 dac go-librespot[1783]: time="2026-05-25T22:01:40+05:30" level=info msg="api server listening on 127.0.0.1:9879"
May 25 22:01:41 dac sudo[1793]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-25 22:00'
May 25 22:01:41 dac sudo[1793]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"