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