-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-06-14 20:53:27 CEST. -- Jun 14 20:52:02 volumio-sovrum volumiologrotate[578]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jun 14 20:52:02 volumio-sovrum volumiologrotate[578]: ls: cannot access 'SOVRUM': No such file or directory Jun 14 20:52:15 volumio-sovrum volumio[1024]: info: [ytcr] InnertubeLoader: obtaining po_token by visitorData... Jun 14 20:52:15 volumio-sovrum volumio[1024]: info: [yt-cast-receiver] Player.stop() Jun 14 20:52:15 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:52:15 volumio-sovrum volumio[1024]: info: CoreCommandRouter::servicePushState Jun 14 20:52:15 volumio-sovrum volumio[1024]: info: CoreStateMachine::pushState Jun 14 20:52:15 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioPushState Jun 14 20:52:15 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output update for this device Jun 14 20:52:15 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output Jun 14 20:52:15 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:52:15 volumio-sovrum volumio[1024]: info: [yt-cast-receiver] Player.play(): Fplgu4VVb94 @ 69s Jun 14 20:52:15 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:52:15 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:52:15 volumio-sovrum volumio[1024]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.amD0dZqJW8Saf6qYu6TN0hEzFCH2.f9351c397594567abe2b55c4e5a5e3e7.state.track' Jun 14 20:52:17 volumio-sovrum volumio[1024]: info: [ytcr] InnertubeLoader: obtained po_token (expires in 43200 seconds) Jun 14 20:52:17 volumio-sovrum volumio[1024]: info: [ytcr] InnertubeLoader: re-create Innertube instance with po_token Jun 14 20:52:17 volumio-sovrum volumio[1024]: info: [ytcr] InnertubeLoader: creating Innertube instance with po_token... Jun 14 20:52:18 volumio-sovrum volumio[1024]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. Jun 14 20:52:25 volumio-sovrum volumio-remote-updater[571]: [2025-06-14 20:52:25] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Jun 14 20:52:30 volumio-sovrum volumio-remote-updater[571]: [2025-06-14 20:52:30] [connect] Successful connection Jun 14 20:52:34 volumio-sovrum volumio[1024]: info: [ytcr] InnertubeLoader: going to refresh po_token in 43100 seconds Jun 14 20:52:34 volumio-sovrum volumio[1024]: info: [ytcr] InnertubeLoader: creating Innertube instance... Jun 14 20:52:35 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to 192.168.68.129:3000 from 192.168.68.115 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jun 14 20:52:35 volumio-sovrum volumio-remote-updater[571]: [2025-06-14 20:52:35] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749927150 101 Jun 14 20:52:35 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 Jun 14 20:52:35 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to 192.168.68.129:3000 from 192.168.68.115 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 14 20:52:35 volumio-sovrum volumio[1024]: info: Discovery: Disconnected from remote: 192.168.68.115 Jun 14 20:52:35 volumio-sovrum volumio[1024]: info: MRS: Cleaning up device: f84a0dd6-a996-4629-987e-7b48c643e78a Jun 14 20:52:35 volumio-sovrum volumio[1024]: info: Removing audio output: Jun 14 20:52:35 volumio-sovrum volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jun 14 20:52:35 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:52:35 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 14 20:52:35 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:52:35 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jun 14 20:52:36 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:52:36 volumio-sovrum volumio[1024]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.amD0dZqJW8Saf6qYu6TN0hEzFCH2.f9351c397594567abe2b55c4e5a5e3e7.state.track' Jun 14 20:52:36 volumio-sovrum volumio[1024]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. Jun 14 20:52:52 volumio-sovrum volumio[1024]: info: [ytcr] InnertubeLoader: obtaining po_token by visitorData... Jun 14 20:52:52 volumio-sovrum volumio[1024]: info: Discovery: Connecting to remote: 192.168.68.115 Jun 14 20:52:52 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 14 20:52:52 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 14 20:52:52 volumio-sovrum volumio[1024]: info: MRS: Pushing audio output on request Jun 14 20:52:52 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output Jun 14 20:52:52 volumio-sovrum volumio[1024]: info: Discovery: Connected to remote: 192.168.68.115 Jun 14 20:52:52 volumio-sovrum volumio[1024]: info: MRS: Adding multiroomSync output Jun 14 20:52:52 volumio-sovrum volumio[1024]: info: Adding audio output: Jun 14 20:52:52 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output Jun 14 20:52:54 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 14 20:52:54 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:52:54 volumio-sovrum volumio[1024]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.amD0dZqJW8Saf6qYu6TN0hEzFCH2.f9351c397594567abe2b55c4e5a5e3e7.state.track' Jun 14 20:52:54 volumio-sovrum volumio[1024]: info: [ytcr] InnertubeLoader: obtained po_token (expires in 43200 seconds) Jun 14 20:52:54 volumio-sovrum volumio[1024]: info: [ytcr] InnertubeLoader: re-create Innertube instance with po_token Jun 14 20:52:54 volumio-sovrum volumio[1024]: info: [ytcr] InnertubeLoader: creating Innertube instance with po_token... Jun 14 20:52:54 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 14 20:52:55 volumio-sovrum volumio[1024]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm. Jun 14 20:53:02 volumio-sovrum volumiologrotate[578]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jun 14 20:53:02 volumio-sovrum volumiologrotate[578]: ls: cannot access 'SOVRUM': No such file or directory Jun 14 20:53:05 volumio-sovrum volumio-remote-updater[571]: [2025-06-14 20:53:05] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Jun 14 20:53:10 volumio-sovrum volumio-remote-updater[571]: [2025-06-14 20:53:10] [connect] Successful connection Jun 14 20:53:11 volumio-sovrum volumio[1024]: info: [ytcr] InnertubeLoader: going to refresh po_token in 43100 seconds Jun 14 20:53:11 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:11 volumio-sovrum volumio[1024]: info: CoreCommandRouter::servicePushState Jun 14 20:53:11 volumio-sovrum volumio[1024]: info: CoreStateMachine::pushState Jun 14 20:53:11 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioPushState Jun 14 20:53:11 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output update for this device Jun 14 20:53:11 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output Jun 14 20:53:11 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:11 volumio-sovrum volumio[1024]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.amD0dZqJW8Saf6qYu6TN0hEzFCH2.f9351c397594567abe2b55c4e5a5e3e7.state.track' Jun 14 20:53:12 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to 192.168.68.129:3000 from 192.168.68.115 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 14 20:53:12 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to 192.168.68.129:3000 from 192.168.68.115 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jun 14 20:53:12 volumio-sovrum volumio-remote-updater[571]: [2025-06-14 20:53:12] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749927190 101 Jun 14 20:53:12 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 6 Jun 14 20:53:12 volumio-sovrum volumio[1024]: info: [yt-cast-receiver] Player.setVolume(): Jun 14 20:53:12 volumio-sovrum volumio[1024]: { level: 65, muted: false } Jun 14 20:53:12 volumio-sovrum volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jun 14 20:53:12 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:13 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:13 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:13 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:13 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:13 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:13 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:13 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:13 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:13 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:13 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:13 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:13 volumio-sovrum volumio[1024]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 14 20:53:13 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:14 volumio-sovrum volumio[1024]: error: [ytcr] MPD error: Jun 14 20:53:14 volumio-sovrum volumio[1024]: (MPDError) Failed to decode https://rr4---sn-jvhixh-hhml.googlevideo.com/videoplayback?expire=1749948793&ei=GcVNaMGGCNrCv_IPg4iXmAg&ip=83.251.137.69&id=o-ANK49fXzxEIWahR_xQ6yuL3k4tVr6NAlfMfA0znSH4Xl&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749927193%2C&mh=LR&mm=31%2C29&mn=sn-jvhixh-hhml%2Csn-jvhixh-5gok&ms=au%2Crdu&mv=m&mvi=4&pcm2cms=yes&pl=21&rms=au%2Cau&ctier=A&pfa=5&gcr=se&initcwndbps=2811250&hightc=yes&siu=1&bui=AY1jyLNGVSBRGIzbNLkqSUPW_YXUOytewdxe8Z6Cigp634o4p-GD1NbCZ4ou0zTIr-jj00us4g&spc=l3OVKVsolNYLhBr_LsKdPqacILXm3zWFll5XgCwPp0e_btAiBGM7EDCwPsfjMrUCUVL5LE_eOGk5Xuw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=3y0fhuYHMdMFWDlMK0Yvaf0Q&rqh=1&gir=yes&clen=5808489&dur=172.541&lmt=1714471434660169&mt=1749926939&fvip=6&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=UL8BNs3G329qOA3UQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%; got HTTP status 403 Jun 14 20:53:14 volumio-sovrum volumio[1024]: MPDError: Failed to decode https://rr4---sn-jvhixh-hhml.googlevideo.com/videoplayback?expire=1749948793&ei=GcVNaMGGCNrCv_IPg4iXmAg&ip=83.251.137.69&id=o-ANK49fXzxEIWahR_xQ6yuL3k4tVr6NAlfMfA0znSH4Xl&itag=774&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1749927193%2C&mh=LR&mm=31%2C29&mn=sn-jvhixh-hhml%2Csn-jvhixh-5gok&ms=au%2Crdu&mv=m&mvi=4&pcm2cms=yes&pl=21&rms=au%2Cau&ctier=A&pfa=5&gcr=se&initcwndbps=2811250&hightc=yes&siu=1&bui=AY1jyLNGVSBRGIzbNLkqSUPW_YXUOytewdxe8Z6Cigp634o4p-GD1NbCZ4ou0zTIr-jj00us4g&spc=l3OVKVsolNYLhBr_LsKdPqacILXm3zWFll5XgCwPp0e_btAiBGM7EDCwPsfjMrUCUVL5LE_eOGk5Xuw&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=3y0fhuYHMdMFWDlMK0Yvaf0Q&rqh=1&gir=yes&clen=5808489&dur=172.541&lmt=1714471434660169&mt=1749926939&fvip=6&keepalive=yes&c=WEB_REMIX&sefc=1&txp=2318224&n=UL8BNs3G329qOA3UQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%; got HTTP status 403 Jun 14 20:53:14 volumio-sovrum volumio[1024]: at MPDClient._receive (/data/plugins/music_service/ytcr/node_modules/mpd2/lib/index.js:147:24) Jun 14 20:53:14 volumio-sovrum volumio[1024]: at Socket.emit (events.js:315:20) Jun 14 20:53:14 volumio-sovrum volumio[1024]: at addChunk (internal/streams/readable.js:309:12) Jun 14 20:53:14 volumio-sovrum volumio[1024]: at readableAddChunk (internal/streams/readable.js:280:11) Jun 14 20:53:14 volumio-sovrum volumio[1024]: at Socket.Readable.push (internal/streams/readable.js:223:10) Jun 14 20:53:14 volumio-sovrum volumio[1024]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jun 14 20:53:14 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:14 volumio-sovrum volumio[1024]: info: Ignoring MPD Status Update Jun 14 20:53:14 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:14 volumio-sovrum volumio[1024]: info: CoreCommandRouter::servicePushState Jun 14 20:53:14 volumio-sovrum volumio[1024]: info: CoreStateMachine::pushState Jun 14 20:53:14 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioPushState Jun 14 20:53:14 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output update for this device Jun 14 20:53:14 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output Jun 14 20:53:14 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:14 volumio-sovrum volumio[1024]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.amD0dZqJW8Saf6qYu6TN0hEzFCH2.f9351c397594567abe2b55c4e5a5e3e7.state.track' Jun 14 20:53:24 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:24.252 [1486.4758] INFO SampleApp: API endpoint invoked: get-display-info Jun 14 20:53:24 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:24.273 [1486.4758] INFO SampleApp: API endpoint invoked: get-connect-info Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.726 [1486.4758] INFO SampleApp: API endpoint invoked: connect-to-qconnect Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.727 [1486.1486] INFO EndpointManager: [0x182ad30]: Updating API endpoint Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.727 [1486.1486] INFO EndpointManager: [0x182ad30]: Updating QConnect endpoint Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.727 [1486.1486] INFO ActiveStateManager: [0x1829d48]: Setting new active state: active Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.727 [1486.1486] INFO PlaybackSessionManager: [0x182b120]: Starting playback session maintenance Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.727 [1486.1486] INFO HttpDownloader: [0x182b310]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.727 [1486.1486] INFO CloudClient: [0x182b990]: Connecting to the cloud Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.728 [1486.1486] INFO SampleApp: Renderer is now active Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.991 [1486.1486] INFO CloudClient: [0x182b990]: Connection established Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.992 [1486.1486] INFO QwspMessageSender: [0x1935b20]: Sending Authenticate message Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.992 [1486.1486] INFO QwspMessageSender: [0x1935b20]: Sending Subscribe message Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.992 [1486.1486] INFO QConnectMessageSender: [0x186b618]: Sending JoinSession message Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.992 [1486.1486] INFO QConnectMessageSender: [0x186b618]: Sending VolumeChanged message Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.992 [1486.1486] INFO QConnectMessageSender: [0x186b618]: Sending VolumeMuted message Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.992 [1486.1486] INFO QConnectMessageSender: [0x186b618]: Sending MaxAudioQualityChanged message Jun 14 20:53:25 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:25.992 [1486.1486] INFO QwspMessageSender: [0x1935b20]: Sending Payload message Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.009 [1486.1486] INFO PlaybackSessionManager: [0x182b120]: Playback session has been refreshed Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.049 [1486.1486] INFO ProtocolHandler: [0x182baf8]: Received SetActive message: active Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.049 [1486.1486] INFO ProtocolHandler: [0x182baf8]: Received SetState message: Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.049 [1486.1486] INFO ProtocolHandler: [0x182baf8]: Playing state: Playing Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.049 [1486.1486] INFO ProtocolHandler: [0x182baf8]: Playback position: 0 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.049 [1486.1486] INFO ProtocolHandler: [0x182baf8]: Queue version: 4.1 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.049 [1486.1486] INFO ProtocolHandler: [0x182baf8]: Current track: TID: 338338833, QID: 0, Context UUID: 71125ea4-9431-4011-8378-ed9effaeb237 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO ProtocolHandler: [0x182baf8]: Next track: TID: 338338834, QID: 1, Context UUID: 71125ea4-9431-4011-8378-ed9effaeb237 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO MediaEngine: [0x182b3b8]: Stopping playback, clearing tracks Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO MediaEngine: [0x182b3b8]: Initiating playback Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO RendererActionAvailabilityManager: [0x182ba48]: Renderer action 'Next' is available Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO ProtocolHandler: [0x182baf8]: Received SetLoopMode message: Off Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO PlaybackControlsManager: [0x182b790]: Setting new loop mode: Off Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO MediaEngine: [0x182b3b8]: Setting current track: 338338833, initial offset: 0ms Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: Clearing all streams Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: New stream: 1 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO HttpDownloader: [0x182ecf0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=d3d59a9890004ecf6f4fe9effdfb252c&request_ts=1749927206&track_id=338338833 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO HttpDownloader: [0x1831990]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=338338833 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO HttpDownloader: [0x1831c48]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=1b3de73c3db943490e1c41b54994eda6&request_ts=1749927206&track_id=338338833 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: [Stream 1]: Running audio stream Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO ProtocolHandler: [0x182baf8]: Received SetShuffleMode message: disabled Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO PlaybackControlsManager: [0x182b790]: Setting new shuffle mode: disabled Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO MediaEngine: [0x182b3b8]: Setting next track: 338338834 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: New stream: 2 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO HttpDownloader: [0x1831fa8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=ea96ce5f27051db7ec6df6f9f8c8ab3c&request_ts=1749927206&track_id=338338834 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.050 [1486.1486] INFO HttpDownloader: [0x1836790]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=338338834 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.051 [1486.1486] INFO HttpDownloader: [0x1836a00]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=695f9e59e9e6fb52ab39d7c3d4d83360&request_ts=1749927206&track_id=338338834 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.051 [1486.1486] INFO MediaEngine: [0x182b3b8]: Waiting for current stream to start before starting audio renderer Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.178 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4790152&eid=338338834&fmt=7&profile=raw&app_id=174516466&cid=2789982&etsp=1749930806&hmac=kpg1-50EQR-QZ71IKo-Bfu659Vk Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.234 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=4790152&eid=338338833&fmt=7&profile=raw&app_id=174516466&cid=2789982&etsp=1749930806&hmac=zOcR0DZtOZVe0raKmMZibHeF4gQ Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.268 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: [Stream 2]: Metadata became available: Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.268 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: Title: Fluctuations Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.268 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: Artist: Rival Consoles Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.268 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: Album: MindsEye Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.268 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: Album art URL: https://static.qobuz.com/images/covers/pc/lg/s1q4m9igilgpc_600.jpg Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.280 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: [Stream 2]: stream information have been fetched Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.283 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: [Stream 1]: stream information have been fetched Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.283 [1486.1486] INFO UrlAudioSource: [0x19de0b0]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=4790152&eid=338338833&fmt=7&profile=raw&app_id=174516466&cid=2789982&etsp=1749930806&hmac=zOcR0DZtOZVe0raKmMZibHeF4gQ Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.283 [1486.1486] INFO ContentFetcher: [0x1906d78]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=4790152&eid=338338833&fmt=7&profile=raw&app_id=174516466&cid=2789982&etsp=1749930806&hmac=zOcR0DZtOZVe0raKmMZibHeF4gQ, offset: 0 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.283 [1486.1486] INFO AudioRenderer: [0x182b5d8]: Starting audio renderer, initial playback state: Playing Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.283 [1486.1486] INFO SampleApp: [Stream 1]: New audio stream (starting from 0ms) Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: QobuzConnect: setActiveState() Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: QobuzConnect: Set Qobuz connect default volume to 30 Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.290 [1486.1486] INFO VolumeManager: [0x182b820]: Setting new playback volume: 30 Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: QobuzConnect: Stopping currently active service Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioStop Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreStateMachine::stop Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreStateMachine::serviceStop Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::serviceStop Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::servicePushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreStateMachine::pushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioPushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output update for this device Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CorePlayQueue::getTrack 0 Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: QobuzConnect: setActiveState() completed, send playback confirmation Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.311 [1486.1486] INFO SampleApp: Initiating playback, initial state: Playing Jun 14 20:53:26 volumio-sovrum volumio[1024]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.amD0dZqJW8Saf6qYu6TN0hEzFCH2.f9351c397594567abe2b55c4e5a5e3e7.state.track' Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:257:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 65536, but target_pcm volumioOutput has buffer size 32768 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:268:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 65536, but target_pcm volumioOutput has buffer size 32768 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.352 [1486.1486] INFO SampleApp: Playback state changed: Playing Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.352 [1486.1486] INFO StreamingEventReporter: [0x182bf10]: Reporting streaming started event Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.352 [1486.1486] INFO HttpDownloader: [0x182bf68]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.352 [1486.1486] INFO ProtocolHandler: [0x182baf8]: Need to send state update Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.352 [1486.1486] INFO QConnectMessageSender: [0x186b618]: Sending StateUpdated message Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.353 [1486.1486] INFO QwspMessageSender: [0x1935b20]: Sending Payload message Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.353 [1486.1486] INFO QConnectMessageSender: [0x186b618]: Sending FileAudioQualityChanged message Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.354 [1486.1486] INFO QwspMessageSender: [0x1935b20]: Sending Payload message Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.354 [1486.1486] INFO QConnectMessageSender: [0x186b618]: Sending DeviceAudioQualityChanged message Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.354 [1486.1486] INFO QwspMessageSender: [0x1935b20]: Sending Payload message Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.355 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: [Stream 1]: Metadata became available: Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.355 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: Title: Theme Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.355 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: Artist: Rival Consoles Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.355 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: Album: MindsEye Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.355 [1486.1486] INFO AudioStreamManager: [0x182b4a0]: Album art URL: https://static.qobuz.com/images/covers/pc/lg/s1q4m9igilgpc_600.jpg Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.355 [1486.1486] INFO SampleApp: [Stream 1]: Stream metadata became available: Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.355 [1486.1486] INFO SampleApp: Title: Theme Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.355 [1486.1486] INFO SampleApp: Artist: Rival Consoles Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.355 [1486.1486] INFO SampleApp: Album: MindsEye Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.355 [1486.1486] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/pc/lg/s1q4m9igilgpc_600.jpg Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::servicePushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreStateMachine::pushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioPushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output update for this device Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.367 [1486.1486] INFO VolumeManager: [0x182b820]: Setting new playback volume: 30 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.368 [1486.1486] INFO VolumeManager: [0x182b820]: Setting new mute state: 0 Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::servicePushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreStateMachine::pushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioPushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output update for this device Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::servicePushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreStateMachine::pushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioPushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output update for this device Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::servicePushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreStateMachine::pushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioPushState Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output update for this device Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: MRS: Pushing multiroomSync output Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: CoreCommandRouter::volumioGetState Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.471 [1486.1486] INFO SampleApp: Playback volume changed: 30 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.471 [1486.1486] INFO ProtocolHandler: [0x182baf8]: Volume changed: 30 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.471 [1486.1486] INFO QConnectMessageSender: [0x186b618]: Sending VolumeChanged message Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.471 [1486.1486] INFO QwspMessageSender: [0x1935b20]: Sending Payload message Jun 14 20:53:26 volumio-sovrum volumio[1024]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.amD0dZqJW8Saf6qYu6TN0hEzFCH2.f9351c397594567abe2b55c4e5a5e3e7.state.track' Jun 14 20:53:26 volumio-sovrum volumio[1024]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Jun 14 20:53:26 volumio-sovrum volumio[1024]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 14 20:53:26 volumio-sovrum volumio[1024]: TypeError: Cannot read property 'indexOf' of undefined Jun 14 20:53:26 volumio-sovrum volumio[1024]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 14 20:53:26 volumio-sovrum volumio[1024]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) Jun 14 20:53:26 volumio-sovrum volumio[1024]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.536 [1486.1486] INFO UrlAudioSource: [0x19de0b0]: Content info extracted Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.536 [1486.1486] INFO UrlAudioSource: [0x19de0b0]: Size: 82664656 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.537 [1486.10211] INFO AudioDecoder: [0x1ac8b80]: Stream info: Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.537 [1486.10211] INFO AudioDecoder: [0x1ac8b80]: Total samples: 26574848 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.537 [1486.10211] INFO AudioDecoder: [0x1ac8b80]: Sample rate: 96000 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.537 [1486.10211] INFO AudioDecoder: [0x1ac8b80]: Channel count: 2 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.537 [1486.10211] INFO AudioDecoder: [0x1ac8b80]: Bits per sample: 24 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.537 [1486.10211] INFO AudioDecoder: [0x1ac8b80]: Duration: 276821 Jun 14 20:53:26 volumio-sovrum qobuz-connect[1486]: 20250614 20:53:26.537 [1486.1486] INFO UrlAudioSource: [0x19de0b0]: Audio properties have changed Jun 14 20:53:27 volumio-sovrum sudo[10221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-14 20:52 Jun 14 20:53:27 volumio-sovrum sudo[10221]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"