Mar 27 15:04:06 volumio1 volumio[15756]: info: CoreCommandRouter::volumioGetState Mar 27 15:04:13 volumio1 go-librespot[15944]: time="2026-03-27T15:04:13+01:00" level=trace msg="sent dealer ping" Mar 27 15:04:13 volumio1 go-librespot[15944]: time="2026-03-27T15:04:13+01:00" level=trace msg="received dealer pong" Mar 27 15:04:16 volumio1 volumio[15756]: info: CoreCommandRouter::volumioGetState Mar 27 15:04:16 volumio1 volumio[15756]: info: Listing playlists Mar 27 15:04:16 volumio1 volumio[15756]: info: Listing playlists Mar 27 15:04:26 volumio1 volumio[15756]: info: CoreCommandRouter::volumioGetState Mar 27 15:04:36 volumio1 volumio[15756]: info: CoreCommandRouter::volumioGetState Mar 27 15:04:36 volumio1 volumio[15756]: info: Listing playlists Mar 27 15:04:36 volumio1 volumio[15756]: info: Listing playlists Mar 27 15:04:43 volumio1 go-librespot[15944]: time="2026-03-27T15:04:43+01:00" level=trace msg="sent dealer ping" Mar 27 15:04:43 volumio1 go-librespot[15944]: time="2026-03-27T15:04:43+01:00" level=trace msg="received dealer pong" Mar 27 15:04:46 volumio1 volumio[15756]: info: CoreCommandRouter::volumioGetState Mar 27 15:04:56 volumio1 volumio[15756]: info: CoreCommandRouter::volumioGetState Mar 27 15:04:56 volumio1 volumio[15756]: info: Listing playlists Mar 27 15:04:56 volumio1 volumio[15756]: info: Listing playlists Mar 27 15:04:59 volumio1 systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Mar 27 15:04:59 volumio1 systemd[1]: setdatetime-helper.service: Deactivated successfully. Mar 27 15:04:59 volumio1 systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Mar 27 15:05:06 volumio1 volumio[15756]: info: CoreCommandRouter::volumioGetState Mar 27 15:05:13 volumio1 go-librespot[15944]: time="2026-03-27T15:05:13+01:00" level=trace msg="sent dealer ping" Mar 27 15:05:13 volumio1 go-librespot[15944]: time="2026-03-27T15:05:13+01:00" level=trace msg="received dealer pong" Mar 27 15:05:16 volumio1 volumio[15756]: info: CoreCommandRouter::volumioGetState Mar 27 15:05:16 volumio1 volumio[15756]: info: Listing playlists Mar 27 15:05:16 volumio1 volumio[15756]: info: Listing playlists Mar 27 15:05:23 volumio1 volumio[15756]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 15:05:23 volumio1 volumio[15756]: AxiosError: connect ETIMEDOUT 10.20.30.73:1400 Mar 27 15:05:23 volumio1 volumio[15756]: at AxiosError.from (/myvolumio/plugins/audio_interface/multiroom/node_modules/axios/dist/node/axios.cjs:842:28) Mar 27 15:05:23 volumio1 volumio[15756]: at RedirectableRequest.handleRequestError (/myvolumio/plugins/audio_interface/multiroom/node_modules/axios/dist/node/axios.cjs:3498:27) Mar 27 15:05:23 volumio1 volumio[15756]: at RedirectableRequest.emit (node:events:514:28) Mar 27 15:05:23 volumio1 volumio[15756]: at eventHandlers. (/myvolumio/plugins/audio_interface/multiroom/node_modules/follow-redirects/index.js:49:24) Mar 27 15:05:23 volumio1 volumio[15756]: at ClientRequest.emit (node:events:514:28) Mar 27 15:05:23 volumio1 volumio[15756]: at Socket.socketErrorListener (node:_http_client:495:9) Mar 27 15:05:23 volumio1 volumio[15756]: at Socket.emit (node:events:514:28) Mar 27 15:05:23 volumio1 volumio[15756]: at emitErrorNT (node:internal/streams/destroy:151:8) Mar 27 15:05:23 volumio1 volumio[15756]: at emitErrorCloseNT (node:internal/streams/destroy:116:3) Mar 27 15:05:23 volumio1 volumio[15756]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) Mar 27 15:05:23 volumio1 volumio[15756]: at Axios.request (/myvolumio/plugins/audio_interface/multiroom/node_modules/axios/dist/node/axios.cjs:4713:41) Mar 27 15:05:23 volumio1 volumio[15756]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) { Mar 27 15:05:23 volumio1 volumio[15756]: isAxiosError: true, Mar 27 15:05:23 volumio1 volumio[15756]: code: 'ETIMEDOUT', Mar 27 15:05:23 volumio1 volumio[15756]: config: { Mar 27 15:05:23 volumio1 volumio[15756]: transitional: { Mar 27 15:05:23 volumio1 volumio[15756]: silentJSONParsing: true, Mar 27 15:05:23 volumio1 volumio[15756]: forcedJSONParsing: true, Mar 27 15:05:23 volumio1 volumio[15756]: clarifyTimeoutError: false Mar 27 15:05:23 volumio1 volumio[15756]: }, Mar 27 15:05:23 volumio1 volumio[15756]: adapter: [ 'xhr', 'http', 'fetch' ], Mar 27 15:05:23 volumio1 volumio[15756]: transformRequest: [ [Function: transformRequest] ], Mar 27 15:05:23 volumio1 volumio[15756]: transformResponse: [ [Function: transformResponse] ], Mar 27 15:05:23 volumio1 volumio[15756]: timeout: 0, Mar 27 15:05:23 volumio1 volumio[15756]: xsrfCookieName: 'XSRF-TOKEN', Mar 27 15:05:23 volumio1 volumio[15756]: xsrfHeaderName: 'X-XSRF-TOKEN', Mar 27 15:05:23 volumio1 volumio[15756]: maxContentLength: -1, Mar 27 15:05:23 volumio1 volumio[15756]: maxBodyLength: -1, Mar 27 15:05:23 volumio1 volumio[15756]: env: { FormData: [Function], Blob: [class Blob] }, Mar 27 15:05:23 volumio1 volumio[15756]: validateStatus: [Function: validateStatus], Mar 27 15:05:23 volumio1 volumio[15756]: headers: Object [AxiosHeaders] { Mar 27 15:05:23 volumio1 volumio[15756]: Accept: 'application/json, text/plain, */*', Mar 27 15:05:23 volumio1 volumio[15756]: 'Content-Type': 'text/xml; charset=utf8', Mar 27 15:05:23 volumio1 volumio[15756]: SOAPAction: '"urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState"', Mar 27 15:05:23 volumio1 volumio[15756]: 'User-Agent': 'axios/1.13.4', Mar 27 15:05:23 volumio1 volumio[15756]: 'Content-Length': '256', Mar 27 15:05:23 volumio1 volumio[15756]: 'Accept-Encoding': 'gzip, compress, deflate, br' Mar 27 15:05:23 volumio1 volumio[15756]: }, Mar 27 15:05:23 volumio1 volumio[15756]: url: 'http://10.20.30.73:1400/ZoneGroupTopology/Control', Mar 27 15:05:23 volumio1 volumio[15756]: method: 'post', Mar 27 15:05:23 volumio1 volumio[15756]: data: '', Mar 27 15:05:23 volumio1 volumio[15756]: allowAbsoluteUrls: true Mar 27 15:05:23 volumio1 volumio[15756]: }, Mar 27 15:05:23 volumio1 volumio[15756]: request: Writable { Mar 27 15:05:23 volumio1 volumio[15756]: _writableState: WritableState { Mar 27 15:05:23 volumio1 volumio[15756]: objectMode: false, Mar 27 15:05:23 volumio1 volumio[15756]: highWaterMark: 16384, Mar 27 15:05:23 volumio1 volumio[15756]: finalCalled: false, Mar 27 15:05:23 volumio1 volumio[15756]: needDrain: false, Mar 27 15:05:23 volumio1 volumio[15756]: ending: false, Mar 27 15:05:23 volumio1 volumio[15756]: ended: false, Mar 27 15:05:23 volumio1 volumio[15756]: finished: false, Mar 27 15:05:23 volumio1 volumio[15756]: destroyed: false, Mar 27 15:05:23 volumio1 volumio[15756]: decodeStrings: true, Mar 27 15:05:23 volumio1 volumio[15756]: defaultEncoding: 'utf8', Mar 27 15:05:23 volumio1 volumio[15756]: length: 0, Mar 27 15:05:23 volumio1 volumio[15756]: writing: false, Mar 27 15:05:23 volumio1 volumio[15756]: corked: 0, Mar 27 15:05:23 volumio1 volumio[15756]: sync: true, Mar 27 15:05:23 volumio1 volumio[15756]: bufferProcessing: false, Mar 27 15:05:23 volumio1 volumio[15756]: onwrite: [Function: bound onwrite], Mar 27 15:05:23 volumio1 volumio[15756]: writecb: null, Mar 27 15:05:23 volumio1 volumio[15756]: writelen: 0, Mar 27 15:05:23 volumio1 volumio[15756]: afterWriteTickInfo: null, Mar 27 15:05:23 volumio1 volumio[15756]: buffered: [], Mar 27 15:05:23 volumio1 volumio[15756]: bufferedIndex: 0, Mar 27 15:05:23 volumio1 volumio[15756]: allBuffers: true, Mar 27 15:05:23 volumio1 volumio[15756]: allNoop: true, Mar 27 15:05:23 volumio1 volumio[15756]: pendingcb: 0, Mar 27 15:05:23 volumio1 volumio[15756]: constructed: true, Mar 27 15:05:23 volumio1 volumio[15756]: prefinished: false, Mar 27 15:05:23 volumio1 volumio[15756]: errorEmitted: false, Mar 27 15:05:23 volumio1 volumio[15756]: emitClose: true, Mar 27 15:05:23 volumio1 volumio[15756]: autoDestroy: true, Mar 27 15:05:23 volumio1 volumio[15756]: errored: null, Mar 27 15:05:23 volumio1 volumio[15756]: closed: false, Mar 27 15:05:23 volumio1 volumio[15756]: closeEmitted: false, Mar 27 15:05:23 volumio1 volumio[15756]: [Symbol(kOnFinished)]: [] Mar 27 15:05:23 volumio1 volumio[15756]: }, Mar 27 15:05:23 volumio1 volumio[15756]: _events: [Object: null prototype] { Mar 27 15:05:23 volumio1 volumio[15756]: response: [Function: handleResponse], Mar 27 15:05:23 volumio1 volumio[15756]: error: [Function: handleRequestError], Mar 27 15:05:23 volumio1 volumio[15756]: socket: [Array] Mar 27 15:05:23 volumio1 volumio[15756]: }, Mar 27 15:05:23 volumio1 volumio[15756]: _eventsCount: 3, Mar 27 15:05:23 volumio1 volumio[15756]: _maxListeners: undefined, Mar 27 15:05:23 volumio1 volumio[15756]: _options: { Mar 27 15:05:23 volumio1 volumio[15756]: maxRedirects: 21, Mar 27 15:05:23 volumio1 volumio[15756]: maxBodyLength: Infinity, Mar 27 15:05:23 volumio1 volumio[15756]: protocol: 'http:', Mar 27 15:05:23 volumio1 volumio[15756]: path: '/ZoneGroupTopology/Control', Mar 27 15:05:23 volumio1 volumio[15756]: method: 'POST', Mar 27 15:05:23 volumio1 volumio[15756]: headers: [Object: null prototype], Mar 27 15:05:23 volumio1 volumio[15756]: agents: [Object], Mar 27 15:05:23 volumio1 volumio[15756]: auth: undefined, Mar 27 15:05:23 volumio1 volumio[15756]: family: undefined, Mar 27 15:05:23 volumio1 volumio[15756]: beforeRedirect: [Function: dispatchBeforeRedirect], Mar 27 15:05:23 volumio1 volumio[15756]: beforeRedirects: [Object], Mar 27 15:05:23 volumio1 volumio[15756]: http2Options: undefined, Mar 27 15:05:23 volumio1 volumio[15756]: hostname: '10.20.30.73', Mar 27 15:05:23 volumio1 volumio[15756]: port: '1400', Mar 27 15:05:23 volumio1 volumio[15756]: agent: undefined, Mar 27 15:05:23 volumio1 volumio[15756]: nativeProtocols: [Object], Mar 27 15:05:23 volumio1 volumio[15756]: pathname: '/ZoneGroupTopology/Control' Mar 27 15:05:23 volumio1 volumio[15756]: }, Mar 27 15:05:23 volumio1 volumio[15756]: _ended: true, Mar 27 15:05:23 volumio1 volumio[15756]: _ending: true, Mar 27 15:05:23 volumio1 volumio[15756]: _redirectCount: 0, Mar 27 15:05:23 volumio1 volumio[15756]: _redirects: [], Mar 27 15:05:23 volumio1 volumio[15756]: _requestBodyLength: 256, Mar 27 15:05:23 volumio1 volumio[15756]: _requestBodyBuffers: [ [Object] ], Mar 27 15:05:23 volumio1 volumio[15756]: _onNativeResponse: [Function (anonymous)], Mar 27 15:05:23 volumio1 volumio[15756]: _currentRequest: ClientRequest { Mar 27 15:05:23 volumio1 volumio[15756]: _events: [Object: null prototype], Mar 27 15:05:23 volumio1 volumio[15756]: _eventsCount: 7, Mar 27 15:05:23 volumio1 volumio[15756]: _maxListeners: undefined, Mar 27 15:05:23 volumio1 volumio[15756]: outputData: [], Mar 27 15:05:23 volumio1 volumio[15756]: outputSize: 0, Mar 27 15:05:23 volumio1 volumio[15756]: writable: true, Mar 27 15:05:23 volumio1 volumio[15756]: destroyed: false, Mar 27 15:05:23 volumio1 volumio[15756]: _last: false, Mar 27 15:05:23 volumio1 volumio[15756]: chunkedEncoding: false, Mar 27 15:05:23 volumio1 volumio[15756]: shouldKeepAlive: true, Mar 27 15:05:23 volumio1 volumio[15756]: maxRequestsOnConnectionReached: false, Mar 27 15:05:23 volumio1 volumio[15756]: _defaultKeepAlive: true, Mar 27 15:05:23 volumio1 volumio[15756]: useChunkedEncodingByDefault: true, Mar 27 15:05:23 volumio1 volumio[15756]: sendDate: false, Mar 27 15:05:23 volumio1 volumio[15756]: _removedConnection: false, Mar 27 15:05:23 volumio1 volumio[15756]: _removedContLen: false, Mar 27 15:05:23 volumio1 volumio[15756]: _removedTE: false, Mar 27 15:05:23 volumio1 volumio[15756]: strictContentLength: false, Mar 27 15:05:23 volumio1 volumio[15756]: _contentLength: '256', Mar 27 15:05:23 volumio1 volumio[15756]: _hasBody: true, Mar 27 15:05:23 volumio1 volumio[15756]: _trailer: '', Mar 27 15:05:23 volumio1 volumio[15756]: finished: true, Mar 27 15:05:23 volumio1 volumio[15756]: _headerSent: true, Mar 27 15:05:23 volumio1 volumio[15756]: _closed: false, Mar 27 15:05:23 volumio1 volumio[15756]: socket: [Socket], Mar 27 15:05:23 volumio1 volumio[15756]: _header: 'POST /ZoneGroupTopology/Control HTTP/1.1\r\n' + Mar 27 15:05:23 volumio1 volumio[15756]: 'Accept: application/json, text/plain, */*\r\n' + Mar 27 15:05:23 volumio1 volumio[15756]: 'Content-Type: text/xml; charset=utf8\r\n' + Mar 27 15:05:23 volumio1 volumio[15756]: 'SOAPAction: "urn:schemas-upnp-org:service:ZoneGroupTopology:1#GetZoneGroupState"\r\n' + Mar 27 15:05:23 volumio1 volumio[15756]: 'User-Agent: axios/1.13.4\r\n' + Mar 27 15:05:23 volumio1 volumio[15756]: 'Content-Length: 256\r\n' + Mar 27 15:05:23 volumio1 volumio[15756]: 'Accept-Encoding: gzip, compress, deflate, br\r\n' + Mar 27 15:05:23 volumio1 volumio[15756]: 'Host: 10.20.30.73:1400\r\n' + Mar 27 15:05:23 volumio1 volumio[15756]: 'Connection: keep-alive\r\n' + Mar 27 15:05:23 volumio1 volumio[15756]: '\r\n', Mar 27 15:05:23 volumio1 volumio[15756]: _keepAliveTimeout: 0, Mar 27 15:05:23 volumio1 volumio[15756]: _onPendingData: [Function: nop], Mar 27 15:05:23 volumio1 volumio[15756]: agent: [Agent], Mar 27 15:05:23 volumio1 volumio[15756]: socketPath: undefined, Mar 27 15:05:23 volumio1 volumio[15756]: method: 'POST', Mar 27 15:05:23 volumio1 volumio[15756]: maxHeaderSize: undefined, Mar 27 15:05:23 volumio1 volumio[15756]: insecureHTTPParser: undefined, Mar 27 15:05:23 volumio1 volumio[15756]: joinDuplicateHeaders: undefined, Mar 27 15:05:23 volumio1 volumio[15756]: path: '/ZoneGroupTopology/Control', Mar 27 15:05:23 volumio1 volumio[15756]: _ended: false, Mar 27 15:05:23 volumio1 volumio[15756]: res: null, Mar 27 15:05:23 volumio1 volumio[15756]: aborted: false, Mar 27 15:05:23 volumio1 volumio[15756]: timeoutCb: [Function: emitRequestTimeout], Mar 27 15:05:23 volumio1 volumio[15756]: upgradeOrConnect: false, Mar 27 15:05:23 volumio1 volumio[15756]: parser: null, Mar 27 15:05:23 volumio1 volumio[15756]: maxHeadersCount: null, Mar 27 15:05:23 volumio1 volumio[15756]: reusedSocket: false, Mar 27 15:05:23 volumio1 volumio[15756]: host: '10.20.30.73', Mar 27 15:05:23 volumio1 volumio[15756]: protocol: 'http:', Mar 27 15:05:23 volumio1 volumio[15756]: _redirectable: [Circular *1], Mar 27 15:05:23 volumio1 volumio[15756]: [Symbol(kCapture)]: false, Mar 27 15:05:23 volumio1 volumio[15756]: [Symbol(kBytesWritten)]: 0, Mar 27 15:05:23 volumio1 volumio[15756]: [Symbol(kNeedDrain)]: false, Mar 27 15:05:23 volumio1 volumio[15756]: [Symbol(corked)]: 0, Mar 27 15:05:23 volumio1 volumio[15756]: [Symbol(kOutHeaders)]: [Object: null prototype], Mar 27 15:05:23 volumio1 volumio[15756]: [Symbol(errored)]: null, Mar 27 15:05:23 volumio1 volumio[15756]: [Symbol(kHighWaterMark)]: 16384, Mar 27 15:05:23 volumio1 volumio[15756]: [Symbol(kRejectNonStandardBodyWrites)]: false, Mar 27 15:05:23 volumio1 volumio[15756]: [Symbol(kUniqueHeaders)]: null Mar 27 15:05:23 volumio1 volumio[15756]: }, Mar 27 15:05:23 volumio1 volumio[15756]: _currentUrl: 'http://10.20.30.73:1400/ZoneGroupTopology/Control', Mar 27 15:05:23 volumio1 volumio[15756]: _timeout: null, Mar 27 15:05:23 volumio1 volumio[15756]: [Symbol(kCapture)]: false Mar 27 15:05:23 volumio1 volumio[15756]: }, Mar 27 15:05:23 volumio1 volumio[15756]: cause: Error: connect ETIMEDOUT 10.20.30.73:1400 Mar 27 15:05:23 volumio1 volumio[15756]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Mar 27 15:05:23 volumio1 volumio[15756]: errno: -110, Mar 27 15:05:23 volumio1 volumio[15756]: code: 'ETIMEDOUT', Mar 27 15:05:23 volumio1 volumio[15756]: syscall: 'connect', Mar 27 15:05:23 volumio1 volumio[15756]: address: '10.20.30.73', Mar 27 15:05:23 volumio1 volumio[15756]: port: 1400 Mar 27 15:05:23 volumio1 volumio[15756]: } Mar 27 15:05:23 volumio1 volumio[15756]: } Mar 27 15:05:23 volumio1 volumio[15756]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 15:05:23 volumio1 sudo[14219]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-27 15:04' Mar 27 15:05:23 volumio1 sudo[14219]: 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"