-- Logs begin at Sun 2025-05-18 17:46:19 UTC, end at Mon 2025-05-19 13:14:22 UTC. --
May 19 13:13:56 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::volumioGetVisibleSources
May 19 13:13:56 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 19 13:13:56 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::volumioGetState
May 19 13:13:56 stream-box-s2-ultra volumio[973]: info: CorePlayQueue::getTrack 0
May 19 13:13:56 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::volumioGetQueue
May 19 13:13:56 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::getQueue
May 19 13:13:56 stream-box-s2-ultra volumio[973]: info: CorePlayQueue::getQueue
May 19 13:13:56 stream-box-s2-ultra volumio[973]: info: Listing playlists
May 19 13:13:56 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 19 13:13:56 stream-box-s2-ultra volumio[973]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
May 19 13:14:00 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::volumioPlay
May 19 13:14:00 stream-box-s2-ultra volumio[973]: verbose: UNSET VOLATILE
May 19 13:14:00 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::play index undefined
May 19 13:14:00 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined
May 19 13:14:00 stream-box-s2-ultra volumio[973]: info: CorePlayQueue::getTrack 0
May 19 13:14:00 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::startPlaybackTimer
May 19 13:14:00 stream-box-s2-ultra volumio[973]: info: CorePlayQueue::getTrack 0
May 19 13:14:00 stream-box-s2-ultra volumio[973]: info: [1747660440740] ControllerQobuz::clearAddPlayTrack
May 19 13:14:01 stream-box-s2-ultra volumio[973]: info: getStreamUrl took 604 milliseconds
May 19 13:14:01 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::sendMpdCommand stop
May 19 13:14:01 stream-box-s2-ultra volumio[973]: info: sendMpdCommand stop took 7 milliseconds
May 19 13:14:01 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::sendMpdCommand clear
May 19 13:14:01 stream-box-s2-ultra volumio[973]: info:
May 19 13:14:01 stream-box-s2-ultra volumio[973]: ---------------------------- MPD announces system playlist update
May 19 13:14:01 stream-box-s2-ultra volumio[973]: info: Ignoring MPD Status Update
May 19 13:14:01 stream-box-s2-ultra volumio[973]: info: sendMpdCommand clear took 8 milliseconds
May 19 13:14:01 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::sendMpdCommand load "https://streaming-qobuz-std.akamaized.net/file?uid=375700&eid=203578463&fmt=7&profile=raw&app_id=539451548&cid=2741529&etsp=1747664041&hmac=uA0O-0bQPltFBKRz0Cd5B7gsgj0"
May 19 13:14:01 stream-box-s2-ultra volumio[973]: error: updateQueue error: null
May 19 13:14:01 stream-box-s2-ultra volumio[973]: info: ------------------------------ 11ms
May 19 13:14:01 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=375700&eid=203578463&fmt=7&profile=raw&app_id=539451548&cid=2741529&etsp=1747664041&hmac=uA0O-0bQPltFBKRz0Cd5B7gsgj0"
May 19 13:14:01 stream-box-s2-ultra volumio[973]: info:
May 19 13:14:01 stream-box-s2-ultra volumio[973]: ---------------------------- MPD announces system playlist update
May 19 13:14:01 stream-box-s2-ultra volumio[973]: info: Ignoring MPD Status Update
May 19 13:14:01 stream-box-s2-ultra volumio[973]: info: sendMpdCommand add "https://streaming-qobuz-std.akamaized.net/file?uid=375700&eid=203578463&fmt=7&profile=raw&app_id=539451548&cid=2741529&etsp=1747664041&hmac=uA0O-0bQPltFBKRz0Cd5B7gsgj0" took 6 milliseconds
May 19 13:14:01 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::setConsumeUpdateService mpd
May 19 13:14:01 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::sendMpdCommand play
May 19 13:14:01 stream-box-s2-ultra volumio[973]: info: ------------------------------ 13ms
May 19 13:14:01 stream-box-s2-ultra volumio[973]: info: sendMpdCommand play took 8 milliseconds
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info:
May 19 13:14:02 stream-box-s2-ultra volumio[973]: ---------------------------- MPD announces state update: player
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: ControllerMpd::getState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::sendMpdCommand status
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: sendMpdCommand status took 257 milliseconds
May 19 13:14:02 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::parseState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info:
May 19 13:14:02 stream-box-s2-ultra volumio[973]: ---------------------------- MPD announces state update: player
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: ControllerMpd::getState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::sendMpdCommand status
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: sendMpdCommand playlistinfo took 7 milliseconds
May 19 13:14:02 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::parseTrackInfo
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: ControllerMpd::pushState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::servicePushState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CorePlayQueue::getTrack 0
May 19 13:14:02 stream-box-s2-ultra volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":295,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file?uid=375700&eid=203578463&fmt=7&profile=raw&app_id=539451548&cid=2741529&etsp=1747664041&hmac=uA0O-0bQPltFBKRz0Cd5B7gsgj0","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=375700&eid=203578463&fmt=7&profile=raw&app_id=539451548&cid=2741529&etsp=1747664041&hmac=uA0O-0bQPltFBKRz0Cd5B7gsgj0","trackType":"qobuz"}
May 19 13:14:02 stream-box-s2-ultra volumio[973]: verbose: CURRENT POSITION 0
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::syncState stateService play
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::syncState currentStatus stop
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::pushState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::volumioPushState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: ------------------------------ 314ms
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: sendMpdCommand status took 46 milliseconds
May 19 13:14:02 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::parseState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: Updating push state because input changed
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::volumiosetSourceActivempd
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: sendMpdCommand playlistinfo took 31 milliseconds
May 19 13:14:02 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::parseTrackInfo
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: ControllerMpd::pushState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::servicePushState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CorePlayQueue::getTrack 0
May 19 13:14:02 stream-box-s2-ultra volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":295,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1309 Kbps","isStreaming":false,"title":"file?uid=375700&eid=203578463&fmt=7&profile=raw&app_id=539451548&cid=2741529&etsp=1747664041&hmac=uA0O-0bQPltFBKRz0Cd5B7gsgj0","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=375700&eid=203578463&fmt=7&profile=raw&app_id=539451548&cid=2741529&etsp=1747664041&hmac=uA0O-0bQPltFBKRz0Cd5B7gsgj0","trackType":"qobuz"}
May 19 13:14:02 stream-box-s2-ultra volumio[973]: verbose: CURRENT POSITION 0
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::syncState stateService play
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::syncState currentStatus play
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: Received an update from plugin. extracting info from payload
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::pushState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::volumioPushState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::pushState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::volumioPushState
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 19 13:14:02 stream-box-s2-ultra volumio[973]: info: ------------------------------ 116ms
May 19 13:14:03 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
May 19 13:14:03 stream-box-s2-ultra volumio[973]: info: handleBrowseUri took 527 milliseconds
May 19 13:14:03 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:03 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:04 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:04 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:04 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:04 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:04 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:04 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:04 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:04 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:04 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:04 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:06 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:06 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:06 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:06 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:07 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:07 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:07 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:07 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:08 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:08 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:09 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:09 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:09 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:09 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:10 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:10 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:10 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:10 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:10 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:10 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:10 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:10 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:10 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:10 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:10 stream-box-s2-ultra volumio[973]: An internal error occurred while serving an albumart. Details: BadRequestError: request aborted
May 19 13:14:10 stream-box-s2-ultra volumio[973]: at IncomingMessage.onAborted (/volumio/node_modules/raw-body/index.js:231:10)
May 19 13:14:10 stream-box-s2-ultra volumio[973]: at emitNone (events.js:106:13)
May 19 13:14:10 stream-box-s2-ultra volumio[973]: at IncomingMessage.emit (events.js:208:7)
May 19 13:14:10 stream-box-s2-ultra volumio[973]: at abortIncoming (_http_server.js:424:9)
May 19 13:14:10 stream-box-s2-ultra volumio[973]: at socketOnClose (_http_server.js:418:3)
May 19 13:14:10 stream-box-s2-ultra volumio[973]: at emitOne (events.js:121:20)
May 19 13:14:10 stream-box-s2-ultra volumio[973]: at Socket.emit (events.js:211:7)
May 19 13:14:10 stream-box-s2-ultra volumio[973]: at TCP._handle.close [as _onclose] (net.js:567:12)
May 19 13:14:14 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: handleBrowseUri took 533 milliseconds
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:15 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:17 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: Executing endpoint metavolumio
May 19 13:14:18 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::ClearQueue
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::stop
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined
May 19 13:14:20 stream-box-s2-ultra volumio[973]: verbose: UNSET VOLATILE
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::stPlaybackTimer
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::updateTrackBlock
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CorePlayQueue::getTrackBlock
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::pushState
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CorePlayQueue::getTrack 0
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::volumioPushState
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::serviceStop
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CorePlayQueue::getTrack 0
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::serviceStop
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: [1747660460529] ControllerQobuz::stop
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::setConsumeUpdateService mpd
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: ControllerMpd::stop
May 19 13:14:20 stream-box-s2-ultra volumio[973]: verbose: ControllerMpd::sendMpdCommand stop
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CorePlayQueue::clearPlayQueue
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CorePlayQueue::saveQueue
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::volumioPushState
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreCommandRouter::volumioPushQueue
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CoreStateMachine::addQueueItems
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: CorePlayQueue::addQueueItems
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Adding Item to queue: qobuz://song/117939887
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Exploding uri qobuz://song/117939887 in service qobuz
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Adding Item to queue: qobuz://song/117939888
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Exploding uri qobuz://song/117939888 in service qobuz
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Adding Item to queue: qobuz://song/117939889
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Exploding uri qobuz://song/117939889 in service qobuz
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Adding Item to queue: qobuz://song/117939890
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Exploding uri qobuz://song/117939890 in service qobuz
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Adding Item to queue: qobuz://song/117939891
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Exploding uri qobuz://song/117939891 in service qobuz
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Adding Item to queue: qobuz://song/117939892
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Exploding uri qobuz://song/117939892 in service qobuz
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Adding Item to queue: qobuz://song/117939893
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Exploding uri qobuz://song/117939893 in service qobuz
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Adding Item to queue: qobuz://song/117939894
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Exploding uri qobuz://song/117939894 in service qobuz
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Adding Item to queue: qobuz://song/117939895
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Exploding uri qobuz://song/117939895 in service qobuz
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Adding Item to queue: qobuz://song/117939896
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Exploding uri qobuz://song/117939896 in service qobuz
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Adding Item to queue: qobuz://song/117939897
May 19 13:14:20 stream-box-s2-ultra volumio[973]: info: Exploding uri qobuz://song/117939897 in service qobuz
May 19 13:14:20 stream-box-s2-ultra systemd-journal[2018]: Runtime journal is using 8.0M (max allowed 30.0M, trying to leave 70.4M free of 460.9M available → current limit 30.0M).
May 19 13:14:20 stream-box-s2-ultra systemd-journald[205]: Failed to read from stream: Bad address
May 19 13:14:20 stream-box-s2-ultra kernel: Unable to handle kernel NULL pointer dereference at virtual address 00000030
May 19 13:14:20 stream-box-s2-ultra kernel: pgd = b9200000
May 19 13:14:20 stream-box-s2-ultra kernel: [00000030] *pgd=00000000
May 19 13:14:20 stream-box-s2-ultra kernel: Internal error: Oops: 5 [#1] SMP ARM
May 19 13:14:20 stream-box-s2-ultra kernel: Modules linked in: xt_REDIRECT nf_nat_redirect xt_tcpudp iptable_nat nf_conntrack_ipv4 nf_defrag_ipv4 bnep nf_nat_ipv4 nf_nat nf_conntrack ip_tables x_tables nfsd 8723bu(O) snd_usb_audio snd_hwdep snd_usbmidi_lib snd_seq_midi snd_seq_midi_event snd_rawmidi snd_pcm btusb(O) btrtl(O) btintel(O) btbcm(O) cfg80211 snd_seq bluetooth snd_seq_device snd_timer evdev rfkill snd sg bcm2835_gpiomem fixed uio_pdrv_genirq uio i2c_dev ipv6 fuse squashfs overlay
May 19 13:14:20 stream-box-s2-ultra kernel: CPU: 3 PID: 205 Comm: systemd-journal Tainted: G O 4.9.65-v7+ #1
May 19 13:14:20 stream-box-s2-ultra kernel: Hardware name: BCM2835
May 19 13:14:20 stream-box-s2-ultra kernel: task: aea23b00 task.stack: b91d2000
May 19 13:14:20 stream-box-s2-ultra kernel: PC is at skb_release_head_state+0x48/0x138
May 19 13:14:20 stream-box-s2-ultra kernel: LR is at skb_release_all+0x1c/0x34
May 19 13:14:20 stream-box-s2-ultra kernel: pc : [<805ffd9c>] lr : [<80600060>] psr: 20000013
sp : b91d3e50 ip : b91d3e68 fp : b91d3e64
May 19 13:14:20 stream-box-s2-ultra kernel: r10: b7e83384 r9 : 00000000 r8 : b91d3ea0
May 19 13:14:20 stream-box-s2-ultra kernel: r7 : 00000001 r6 : 806c0390 r5 : b7c59240 r4 : b7c59240
May 19 13:14:20 stream-box-s2-ultra kernel: r3 : 00000001 r2 : b7e83384 r1 : 20000013 r0 : 00000030
May 19 13:14:20 stream-box-s2-ultra kernel: Flags: nzCv IRQs on FIQs on Mode SVC_32 ISA ARM Segment user
May 19 13:14:20 stream-box-s2-ultra kernel: Control: 10c5383d Table: 3920006a DAC: 00000055
May 19 13:14:20 stream-box-s2-ultra kernel: Process systemd-journal (pid: 205, stack limit = 0xb91d2210)
May 19 13:14:20 stream-box-s2-ultra kernel: Stack: (0xb91d3e50 to 0xb91d4000)
May 19 13:14:20 stream-box-s2-ultra kernel: 3e40: 00000001 b7c59240 b91d3e7c b91d3e68
May 19 13:14:20 stream-box-s2-ultra kernel: 3e60: 80600060 805ffd60 00000001 b7c59240 b91d3e9c b91d3e80 806000dc 80600050
May 19 13:14:20 stream-box-s2-ultra kernel: 3e80: 00000030 b7c59240 b7e83300 b7e83384 b91d3ed4 b91d3ea0 806c0390 806000ac
May 19 13:14:20 stream-box-s2-ultra kernel: 3ea0: aeb9d410 aec01e58 baf70fc0 a64e6000 00000000 ba8a4b10 a64022a8 a64e6020
May 19 13:14:20 stream-box-s2-ultra kernel: 3ec0: 00000008 00000000 b91d3eec b91d3ed8 806c04e8 806c0230 80849d94 a64e6000
May 19 13:14:20 stream-box-s2-ultra kernel: 3ee0: b91d3f04 b91d3ef0 805f7bbc 806c04c8 b5b86300 a64e6020 b91d3f14 b91d3f08
May 19 13:14:20 stream-box-s2-ultra kernel: 3f00: 805f7c64 805f7b98 b91d3f54 b91d3f18 8026b57c 805f7c54 00000000 00000000
May 19 13:14:20 stream-box-s2-ultra kernel: 3f20: 80139b20 b5b86308 b5b86300 aea23fe8 80c7bee0 00000504 00000000 aea23b00
May 19 13:14:20 stream-box-s2-ultra kernel: 3f40: b91d2000 00000000 b91d3f64 b91d3f58 8026b734 8026b4ec b91d3f8c b91d3f68
May 19 13:14:20 stream-box-s2-ultra kernel: 3f60: 80139cbc 8026b728 b5b86300 00000004 b91d2000 80107fa4 b91d3fb0 80107fa4
May 19 13:14:20 stream-box-s2-ultra kernel: 3f80: b91d3fac b91d3f90 8010b4d8 80139bf4 0000000e 76c6e524 7e9df748 00000006
May 19 13:14:20 stream-box-s2-ultra kernel: 3fa0: 00000000 b91d3fb0 80107e48 8010b420 00000000 00000000 018f5058 00000064
May 19 13:14:20 stream-box-s2-ultra kernel: 3fc0: 0000000e 76c6e524 7e9df748 00000006 76fd1f10 018f50a0 018f5088 7e9dfa1c
May 19 13:14:20 stream-box-s2-ultra kernel: 3fe0: 00000000 7e9df70c 00463188 76f88d3c 60000010 00000015 3553555d 5557777d
May 19 13:14:20 stream-box-s2-ultra kernel: [<805ffd9c>] (skb_release_head_state) from [<80600060>] (skb_release_all+0x1c/0x34)
May 19 13:14:20 stream-box-s2-ultra kernel: [<80600060>] (skb_release_all) from [<806000dc>] (kfree_skb+0x3c/0xec)
May 19 13:14:20 stream-box-s2-ultra kernel: [<806000dc>] (kfree_skb) from [<806c0390>] (unix_release_sock+0x16c/0x298)
May 19 13:14:20 stream-box-s2-ultra kernel: [<806c0390>] (unix_release_sock) from [<806c04e8>] (unix_release+0x2c/0x3c)
May 19 13:14:20 stream-box-s2-ultra kernel: [<806c04e8>] (unix_release) from [<805f7bbc>] (sock_release+0x30/0xbc)
May 19 13:14:20 stream-box-s2-ultra kernel: [<805f7bbc>] (sock_release) from [<805f7c64>] (sock_close+0x1c/0x24)
May 19 13:14:20 stream-box-s2-ultra kernel: [<805f7c64>] (sock_close) from [<8026b57c>] (__fput+0x9c/0x1dc)
May 19 13:14:20 stream-box-s2-ultra kernel: [<8026b57c>] (__fput) from [<8026b734>] (____fput+0x18/0x1c)
May 19 13:14:20 stream-box-s2-ultra kernel: [<8026b734>] (____fput) from [<80139cbc>] (task_work_run+0xd4/0xf8)
May 19 13:14:20 stream-box-s2-ultra kernel: [<80139cbc>] (task_work_run) from [<8010b4d8>] (do_work_pending+0xc4/0xc8)
May 19 13:14:20 stream-box-s2-ultra kernel: [<8010b4d8>] (do_work_pending) from [<80107e48>] (slow_work_pending+0xc/0x20)
May 19 13:14:20 stream-box-s2-ultra kernel: Code: e3500000 0a000009 f57ff05b f590f000 (e1902f9f)
May 19 13:14:20 stream-box-s2-ultra kernel: ---[ end trace cb63c9f1a920423b ]---
May 19 13:14:20 stream-box-s2-ultra systemd[1]: systemd-journald.service has no holdoff time, scheduling restart.
May 19 13:14:20 stream-box-s2-ultra systemd[1]: Stopping Journal Service...
May 19 13:14:20 stream-box-s2-ultra systemd[1]: Starting Journal Service...
May 19 13:14:20 stream-box-s2-ultra systemd[1]: Started Journal Service.
May 19 13:14:20 stream-box-s2-ultra systemd-journal[2018]: Journal started
May 19 13:14:20 stream-box-s2-ultra systemd[1]: systemd-journald.service: main process exited, code=killed, status=11/SEGV
May 19 13:14:20 stream-box-s2-ultra systemd[1]: Unit systemd-journald.service entered failed state.
May 19 13:14:20 stream-box-s2-ultra systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage...
May 19 13:14:20 stream-box-s2-ultra systemd[1]: Started Trigger Flushing of Journal to Persistent Storage.
May 19 13:14:22 stream-box-s2-ultra sudo[2026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-19 13:13
May 19 13:14:22 stream-box-s2-ultra sudo[2026]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1"
VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="projectsbus2"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Jul 13 17:22:02 CEST 2022"
VOLUMIO_VERSION="1.079"
VOLUMIO_HARDWARE="pi"
VOLUMIO_VENDOR="Pro-Ject Audio Systems"
VOLUMIO_MODEL="Stream Box S2 ultra"
VOLUMIO_VENDOR_MODEL="Pro-Ject Stream Box S2 ultra"
VOLUMIO_HASH="a5127ace113e6b9fcf2a1eaed5431093"