Mar 25 04:19:09 volumio1 volumio[12387]: info: CoreCommandRouter::volumioGetState Mar 25 04:19:13 volumio1 go-librespot[12581]: time="2026-03-25T04:19:13+01:00" level=trace msg="sent dealer ping" Mar 25 04:19:13 volumio1 go-librespot[12581]: time="2026-03-25T04:19:13+01:00" level=trace msg="received dealer pong" Mar 25 04:19:19 volumio1 volumio[12387]: info: CoreCommandRouter::volumioGetState Mar 25 04:19:19 volumio1 volumio[12387]: info: Listing playlists Mar 25 04:19:19 volumio1 volumio[12387]: info: Listing playlists Mar 25 04:19:29 volumio1 volumio[12387]: info: CoreCommandRouter::volumioGetState Mar 25 04:19:39 volumio1 volumio[12387]: info: CoreCommandRouter::volumioGetState Mar 25 04:19:39 volumio1 volumio[12387]: info: Listing playlists Mar 25 04:19:39 volumio1 volumio[12387]: info: Listing playlists Mar 25 04:19:43 volumio1 go-librespot[12581]: time="2026-03-25T04:19:43+01:00" level=trace msg="sent dealer ping" Mar 25 04:19:43 volumio1 go-librespot[12581]: time="2026-03-25T04:19:43+01:00" level=trace msg="received dealer pong" Mar 25 04:19:49 volumio1 volumio[12387]: info: CoreCommandRouter::volumioGetState Mar 25 04:19:59 volumio1 volumio[12387]: info: CoreCommandRouter::volumioGetState Mar 25 04:19:59 volumio1 volumio[12387]: info: Listing playlists Mar 25 04:19:59 volumio1 volumio[12387]: info: Listing playlists Mar 25 04:20:00 volumio1 nmbd[1083]: [2026/03/25 04:20:00.308576, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Mar 25 04:20:00 volumio1 nmbd[1083]: query_name_response: Multiple (2) responses received for a query on subnet 10.20.30.13 for name WORKGROUP<1d>. Mar 25 04:20:00 volumio1 nmbd[1083]: This response was from IP 10.20.30.17, reporting an IP address of 10.20.30.17. Mar 25 04:20:09 volumio1 volumio[12387]: info: CoreCommandRouter::volumioGetState Mar 25 04:20:13 volumio1 go-librespot[12581]: time="2026-03-25T04:20:13+01:00" level=trace msg="received accesspoint ping" Mar 25 04:20:13 volumio1 go-librespot[12581]: time="2026-03-25T04:20:13+01:00" level=trace msg="received accesspoint pong ack" Mar 25 04:20:13 volumio1 go-librespot[12581]: time="2026-03-25T04:20:13+01:00" level=trace msg="sent dealer ping" Mar 25 04:20:13 volumio1 go-librespot[12581]: time="2026-03-25T04:20:13+01:00" level=trace msg="received dealer pong" Mar 25 04:20:19 volumio1 volumio[12387]: info: CoreCommandRouter::volumioGetState Mar 25 04:20:19 volumio1 volumio[12387]: info: Listing playlists Mar 25 04:20:19 volumio1 volumio[12387]: info: Listing playlists Mar 25 04:20:29 volumio1 volumio[12387]: info: CoreCommandRouter::volumioGetState Mar 25 04:20:39 volumio1 volumio[12387]: info: CoreCommandRouter::volumioGetState Mar 25 04:20:39 volumio1 volumio[12387]: info: Listing playlists Mar 25 04:20:39 volumio1 volumio[12387]: info: Listing playlists Mar 25 04:20:43 volumio1 go-librespot[12581]: time="2026-03-25T04:20:43+01:00" level=trace msg="sent dealer ping" Mar 25 04:20:43 volumio1 go-librespot[12581]: time="2026-03-25T04:20:43+01:00" level=trace msg="received dealer pong" Mar 25 04:20:46 volumio1 volumio[12387]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 04:20:46 volumio1 volumio[12387]: AxiosError: connect ETIMEDOUT 10.20.30.71:1400 Mar 25 04:20:46 volumio1 volumio[12387]: at AxiosError.from (/myvolumio/plugins/audio_interface/multiroom/node_modules/axios/dist/node/axios.cjs:842:28) Mar 25 04:20:46 volumio1 volumio[12387]: at RedirectableRequest.handleRequestError (/myvolumio/plugins/audio_interface/multiroom/node_modules/axios/dist/node/axios.cjs:3498:27) Mar 25 04:20:46 volumio1 volumio[12387]: at RedirectableRequest.emit (node:events:514:28) Mar 25 04:20:46 volumio1 volumio[12387]: at eventHandlers. (/myvolumio/plugins/audio_interface/multiroom/node_modules/follow-redirects/index.js:49:24) Mar 25 04:20:46 volumio1 volumio[12387]: at ClientRequest.emit (node:events:514:28) Mar 25 04:20:46 volumio1 volumio[12387]: at Socket.socketErrorListener (node:_http_client:495:9) Mar 25 04:20:46 volumio1 volumio[12387]: at Socket.emit (node:events:514:28) Mar 25 04:20:46 volumio1 volumio[12387]: at emitErrorNT (node:internal/streams/destroy:151:8) Mar 25 04:20:46 volumio1 volumio[12387]: at emitErrorCloseNT (node:internal/streams/destroy:116:3) Mar 25 04:20:46 volumio1 volumio[12387]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) Mar 25 04:20:46 volumio1 volumio[12387]: at Axios.request (/myvolumio/plugins/audio_interface/multiroom/node_modules/axios/dist/node/axios.cjs:4713:41) Mar 25 04:20:46 volumio1 volumio[12387]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) { Mar 25 04:20:46 volumio1 volumio[12387]: isAxiosError: true, Mar 25 04:20:46 volumio1 volumio[12387]: code: 'ETIMEDOUT', Mar 25 04:20:46 volumio1 volumio[12387]: config: { Mar 25 04:20:46 volumio1 volumio[12387]: transitional: { Mar 25 04:20:46 volumio1 volumio[12387]: silentJSONParsing: true, Mar 25 04:20:46 volumio1 volumio[12387]: forcedJSONParsing: true, Mar 25 04:20:46 volumio1 volumio[12387]: clarifyTimeoutError: false Mar 25 04:20:46 volumio1 volumio[12387]: }, Mar 25 04:20:46 volumio1 volumio[12387]: adapter: [ 'xhr', 'http', 'fetch' ], Mar 25 04:20:46 volumio1 volumio[12387]: transformRequest: [ [Function: transformRequest] ], Mar 25 04:20:46 volumio1 volumio[12387]: transformResponse: [ [Function: transformResponse] ], Mar 25 04:20:46 volumio1 volumio[12387]: timeout: 0, Mar 25 04:20:46 volumio1 volumio[12387]: xsrfCookieName: 'XSRF-TOKEN', Mar 25 04:20:46 volumio1 volumio[12387]: xsrfHeaderName: 'X-XSRF-TOKEN', Mar 25 04:20:46 volumio1 volumio[12387]: maxContentLength: -1, Mar 25 04:20:46 volumio1 volumio[12387]: maxBodyLength: -1, Mar 25 04:20:46 volumio1 volumio[12387]: env: { FormData: [Function], Blob: [class Blob] }, Mar 25 04:20:46 volumio1 volumio[12387]: validateStatus: [Function: validateStatus], Mar 25 04:20:46 volumio1 volumio[12387]: headers: Object [AxiosHeaders] { Mar 25 04:20:46 volumio1 volumio[12387]: Accept: 'application/json, text/plain, */*', Mar 25 04:20:46 volumio1 volumio[12387]: 'Content-Type': 'text/xml; charset=utf8', Mar 25 04:20:46 volumio1 volumio[12387]: SOAPAction: '"urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState"', Mar 25 04:20:46 volumio1 volumio[12387]: 'User-Agent': 'axios/1.13.4', Mar 25 04:20:46 volumio1 volumio[12387]: 'Content-Length': '256', Mar 25 04:20:46 volumio1 volumio[12387]: 'Accept-Encoding': 'gzip, compress, deflate, br' Mar 25 04:20:46 volumio1 volumio[12387]: }, Mar 25 04:20:46 volumio1 volumio[12387]: url: 'http://10.20.30.71:1400/ZoneGroupTopology/Control', Mar 25 04:20:46 volumio1 volumio[12387]: method: 'post', Mar 25 04:20:46 volumio1 volumio[12387]: data: '', Mar 25 04:20:46 volumio1 volumio[12387]: allowAbsoluteUrls: true Mar 25 04:20:46 volumio1 volumio[12387]: }, Mar 25 04:20:46 volumio1 volumio[12387]: request: Writable { Mar 25 04:20:46 volumio1 volumio[12387]: _writableState: WritableState { Mar 25 04:20:46 volumio1 volumio[12387]: objectMode: false, Mar 25 04:20:46 volumio1 volumio[12387]: highWaterMark: 16384, Mar 25 04:20:46 volumio1 volumio[12387]: finalCalled: false, Mar 25 04:20:46 volumio1 volumio[12387]: needDrain: false, Mar 25 04:20:46 volumio1 volumio[12387]: ending: false, Mar 25 04:20:46 volumio1 volumio[12387]: ended: false, Mar 25 04:20:46 volumio1 volumio[12387]: finished: false, Mar 25 04:20:46 volumio1 volumio[12387]: destroyed: false, Mar 25 04:20:46 volumio1 volumio[12387]: decodeStrings: true, Mar 25 04:20:46 volumio1 volumio[12387]: defaultEncoding: 'utf8', Mar 25 04:20:46 volumio1 volumio[12387]: length: 0, Mar 25 04:20:46 volumio1 volumio[12387]: writing: false, Mar 25 04:20:46 volumio1 volumio[12387]: corked: 0, Mar 25 04:20:46 volumio1 volumio[12387]: sync: true, Mar 25 04:20:46 volumio1 volumio[12387]: bufferProcessing: false, Mar 25 04:20:46 volumio1 volumio[12387]: onwrite: [Function: bound onwrite], Mar 25 04:20:46 volumio1 volumio[12387]: writecb: null, Mar 25 04:20:46 volumio1 volumio[12387]: writelen: 0, Mar 25 04:20:46 volumio1 volumio[12387]: afterWriteTickInfo: null, Mar 25 04:20:46 volumio1 volumio[12387]: buffered: [], Mar 25 04:20:46 volumio1 volumio[12387]: bufferedIndex: 0, Mar 25 04:20:46 volumio1 volumio[12387]: allBuffers: true, Mar 25 04:20:46 volumio1 volumio[12387]: allNoop: true, Mar 25 04:20:46 volumio1 volumio[12387]: pendingcb: 0, Mar 25 04:20:46 volumio1 volumio[12387]: constructed: true, Mar 25 04:20:46 volumio1 volumio[12387]: prefinished: false, Mar 25 04:20:46 volumio1 volumio[12387]: errorEmitted: false, Mar 25 04:20:46 volumio1 volumio[12387]: emitClose: true, Mar 25 04:20:46 volumio1 volumio[12387]: autoDestroy: true, Mar 25 04:20:46 volumio1 volumio[12387]: errored: null, Mar 25 04:20:46 volumio1 volumio[12387]: closed: false, Mar 25 04:20:46 volumio1 volumio[12387]: closeEmitted: false, Mar 25 04:20:46 volumio1 volumio[12387]: [Symbol(kOnFinished)]: [] Mar 25 04:20:46 volumio1 volumio[12387]: }, Mar 25 04:20:46 volumio1 volumio[12387]: _events: [Object: null prototype] { Mar 25 04:20:46 volumio1 volumio[12387]: response: [Function: handleResponse], Mar 25 04:20:46 volumio1 volumio[12387]: error: [Function: handleRequestError], Mar 25 04:20:46 volumio1 volumio[12387]: socket: [Array] Mar 25 04:20:46 volumio1 volumio[12387]: }, Mar 25 04:20:46 volumio1 volumio[12387]: _eventsCount: 3, Mar 25 04:20:46 volumio1 volumio[12387]: _maxListeners: undefined, Mar 25 04:20:46 volumio1 volumio[12387]: _options: { Mar 25 04:20:46 volumio1 volumio[12387]: maxRedirects: 21, Mar 25 04:20:46 volumio1 volumio[12387]: maxBodyLength: Infinity, Mar 25 04:20:46 volumio1 volumio[12387]: protocol: 'http:', Mar 25 04:20:46 volumio1 volumio[12387]: path: '/ZoneGroupTopology/Control', Mar 25 04:20:46 volumio1 volumio[12387]: method: 'POST', Mar 25 04:20:46 volumio1 volumio[12387]: headers: [Object: null prototype], Mar 25 04:20:46 volumio1 volumio[12387]: agents: [Object], Mar 25 04:20:46 volumio1 volumio[12387]: auth: undefined, Mar 25 04:20:46 volumio1 volumio[12387]: family: undefined, Mar 25 04:20:46 volumio1 volumio[12387]: beforeRedirect: [Function: dispatchBeforeRedirect], Mar 25 04:20:46 volumio1 volumio[12387]: beforeRedirects: [Object], Mar 25 04:20:46 volumio1 volumio[12387]: http2Options: undefined, Mar 25 04:20:46 volumio1 volumio[12387]: hostname: '10.20.30.71', Mar 25 04:20:46 volumio1 volumio[12387]: port: '1400', Mar 25 04:20:46 volumio1 volumio[12387]: agent: undefined, Mar 25 04:20:46 volumio1 volumio[12387]: nativeProtocols: [Object], Mar 25 04:20:46 volumio1 volumio[12387]: pathname: '/ZoneGroupTopology/Control' Mar 25 04:20:46 volumio1 volumio[12387]: }, Mar 25 04:20:46 volumio1 volumio[12387]: _ended: true, Mar 25 04:20:46 volumio1 volumio[12387]: _ending: true, Mar 25 04:20:46 volumio1 volumio[12387]: _redirectCount: 0, Mar 25 04:20:46 volumio1 volumio[12387]: _redirects: [], Mar 25 04:20:46 volumio1 volumio[12387]: _requestBodyLength: 256, Mar 25 04:20:46 volumio1 volumio[12387]: _requestBodyBuffers: [ [Object] ], Mar 25 04:20:46 volumio1 volumio[12387]: _onNativeResponse: [Function (anonymous)], Mar 25 04:20:46 volumio1 volumio[12387]: _currentRequest: ClientRequest { Mar 25 04:20:46 volumio1 volumio[12387]: _events: [Object: null prototype], Mar 25 04:20:46 volumio1 volumio[12387]: _eventsCount: 7, Mar 25 04:20:46 volumio1 volumio[12387]: _maxListeners: undefined, Mar 25 04:20:46 volumio1 volumio[12387]: outputData: [], Mar 25 04:20:46 volumio1 volumio[12387]: outputSize: 0, Mar 25 04:20:46 volumio1 volumio[12387]: writable: true, Mar 25 04:20:46 volumio1 volumio[12387]: destroyed: false, Mar 25 04:20:46 volumio1 volumio[12387]: _last: false, Mar 25 04:20:46 volumio1 volumio[12387]: chunkedEncoding: false, Mar 25 04:20:46 volumio1 volumio[12387]: shouldKeepAlive: true, Mar 25 04:20:46 volumio1 volumio[12387]: maxRequestsOnConnectionReached: false, Mar 25 04:20:46 volumio1 volumio[12387]: _defaultKeepAlive: true, Mar 25 04:20:46 volumio1 volumio[12387]: useChunkedEncodingByDefault: true, Mar 25 04:20:46 volumio1 volumio[12387]: sendDate: false, Mar 25 04:20:46 volumio1 volumio[12387]: _removedConnection: false, Mar 25 04:20:46 volumio1 volumio[12387]: _removedContLen: false, Mar 25 04:20:46 volumio1 volumio[12387]: _removedTE: false, Mar 25 04:20:46 volumio1 volumio[12387]: strictContentLength: false, Mar 25 04:20:46 volumio1 volumio[12387]: _contentLength: '256', Mar 25 04:20:46 volumio1 volumio[12387]: _hasBody: true, Mar 25 04:20:46 volumio1 volumio[12387]: _trailer: '', Mar 25 04:20:46 volumio1 volumio[12387]: finished: true, Mar 25 04:20:46 volumio1 volumio[12387]: _headerSent: true, Mar 25 04:20:46 volumio1 volumio[12387]: _closed: false, Mar 25 04:20:46 volumio1 volumio[12387]: socket: [Socket], Mar 25 04:20:46 volumio1 volumio[12387]: _header: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\n' + Mar 25 04:20:46 volumio1 volumio[12387]: 'Accept: application/json, text/plain, */*\r\n' + Mar 25 04:20:46 volumio1 volumio[12387]: 'Content-Type: text/xml; charset=utf8\r\n' + Mar 25 04:20:46 volumio1 volumio[12387]: 'SOAPAction: "urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState"\r\n' + Mar 25 04:20:46 volumio1 volumio[12387]: 'User-Agent: axios/1.13.4\r\n' + Mar 25 04:20:46 volumio1 volumio[12387]: 'Content-Length: 256\r\n' + Mar 25 04:20:46 volumio1 volumio[12387]: 'Accept-Encoding: gzip, compress, deflate, br\r\n' + Mar 25 04:20:46 volumio1 volumio[12387]: 'Host: 10.20.30.71:1400\r\n' + Mar 25 04:20:46 volumio1 volumio[12387]: 'Connection: keep-alive\r\n' + Mar 25 04:20:46 volumio1 volumio[12387]: '\r\n', Mar 25 04:20:46 volumio1 volumio[12387]: _keepAliveTimeout: 0, Mar 25 04:20:46 volumio1 volumio[12387]: _onPendingData: [Function: nop], Mar 25 04:20:46 volumio1 volumio[12387]: agent: [Agent], Mar 25 04:20:46 volumio1 volumio[12387]: socketPath: undefined, Mar 25 04:20:46 volumio1 volumio[12387]: method: 'POST', Mar 25 04:20:46 volumio1 volumio[12387]: maxHeaderSize: undefined, Mar 25 04:20:46 volumio1 volumio[12387]: insecureHTTPParser: undefined, Mar 25 04:20:46 volumio1 volumio[12387]: joinDuplicateHeaders: undefined, Mar 25 04:20:46 volumio1 volumio[12387]: path: '/ZoneGroupTopology/Control', Mar 25 04:20:46 volumio1 volumio[12387]: _ended: false, Mar 25 04:20:46 volumio1 volumio[12387]: res: null, Mar 25 04:20:46 volumio1 volumio[12387]: aborted: false, Mar 25 04:20:46 volumio1 volumio[12387]: timeoutCb: [Function: emitRequestTimeout], Mar 25 04:20:46 volumio1 volumio[12387]: upgradeOrConnect: false, Mar 25 04:20:46 volumio1 volumio[12387]: parser: null, Mar 25 04:20:46 volumio1 volumio[12387]: maxHeadersCount: null, Mar 25 04:20:46 volumio1 volumio[12387]: reusedSocket: false, Mar 25 04:20:46 volumio1 volumio[12387]: host: '10.20.30.71', Mar 25 04:20:46 volumio1 volumio[12387]: protocol: 'http:', Mar 25 04:20:46 volumio1 volumio[12387]: _redirectable: [Circular *1], Mar 25 04:20:46 volumio1 volumio[12387]: [Symbol(kCapture)]: false, Mar 25 04:20:46 volumio1 volumio[12387]: [Symbol(kBytesWritten)]: 0, Mar 25 04:20:46 volumio1 volumio[12387]: [Symbol(kNeedDrain)]: false, Mar 25 04:20:46 volumio1 volumio[12387]: [Symbol(corked)]: 0, Mar 25 04:20:46 volumio1 volumio[12387]: [Symbol(kOutHeaders)]: [Object: null prototype], Mar 25 04:20:46 volumio1 volumio[12387]: [Symbol(errored)]: null, Mar 25 04:20:46 volumio1 volumio[12387]: [Symbol(kHighWaterMark)]: 16384, Mar 25 04:20:46 volumio1 volumio[12387]: [Symbol(kRejectNonStandardBodyWrites)]: false, Mar 25 04:20:46 volumio1 volumio[12387]: [Symbol(kUniqueHeaders)]: null Mar 25 04:20:46 volumio1 volumio[12387]: }, Mar 25 04:20:46 volumio1 volumio[12387]: _currentUrl: 'http://10.20.30.71:1400/ZoneGroupTopology/Control', Mar 25 04:20:46 volumio1 volumio[12387]: _timeout: null, Mar 25 04:20:46 volumio1 volumio[12387]: [Symbol(kCapture)]: false Mar 25 04:20:46 volumio1 volumio[12387]: }, Mar 25 04:20:46 volumio1 volumio[12387]: cause: Error: connect ETIMEDOUT 10.20.30.71:1400 Mar 25 04:20:46 volumio1 volumio[12387]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Mar 25 04:20:46 volumio1 volumio[12387]: errno: -110, Mar 25 04:20:46 volumio1 volumio[12387]: code: 'ETIMEDOUT', Mar 25 04:20:46 volumio1 volumio[12387]: syscall: 'connect', Mar 25 04:20:46 volumio1 volumio[12387]: address: '10.20.30.71', Mar 25 04:20:46 volumio1 volumio[12387]: port: 1400 Mar 25 04:20:46 volumio1 volumio[12387]: } Mar 25 04:20:46 volumio1 volumio[12387]: } Mar 25 04:20:46 volumio1 volumio[12387]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 04:20:47 volumio1 sudo[13085]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-25 04:19' Mar 25 04:20:47 volumio1 sudo[13085]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"