-- Logs begin at Tue 2026-05-19 21:24:15 CEST, end at Thu 2026-05-28 09:46:01 CEST. -- May 28 09:45:30 volumio volumio[16966]: info: May 28 09:45:30 volumio volumio[16966]: ---------------------------- MPD announces system playlist update May 28 09:45:30 volumio volumio[16966]: info: Ignoring MPD Status Update May 28 09:45:30 volumio volumio[16966]: info: May 28 09:45:30 volumio volumio[16966]: ---------------------------- MPD announces state update: player May 28 09:45:30 volumio volumio[16966]: info: ControllerMpd::getState May 28 09:45:30 volumio volumio[16966]: verbose: ControllerMpd::sendMpdCommand status May 28 09:45:30 volumio volumio[16966]: info: ------------------------------ 4ms May 28 09:45:30 volumio volumio[16966]: info: sendMpdCommand status took 2 milliseconds May 28 09:45:30 volumio volumio[16966]: verbose: ControllerMpd::parseState May 28 09:45:30 volumio volumio[16966]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 09:45:30 volumio volumio[16966]: info: sendMpdCommand playlistinfo took 1 milliseconds May 28 09:45:30 volumio volumio[16966]: verbose: ControllerMpd::parseTrackInfo May 28 09:45:30 volumio volumio[16966]: info: ControllerMpd::pushState May 28 09:45:30 volumio volumio[16966]: info: CoreCommandRouter::servicePushState May 28 09:45:30 volumio volumio[16966]: info: CorePlayQueue::getTrack 0 May 28 09:45:30 volumio volumio[16966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":16373276,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Carnaval-Radio.nl - Erwin","artist":null,"album":null,"uri":"https://s20.reliastream.com:8010/stream","trackType":""} May 28 09:45:30 volumio volumio[16966]: verbose: CURRENT POSITION 0 May 28 09:45:30 volumio volumio[16966]: info: CoreStateMachine::syncState stateService play May 28 09:45:30 volumio volumio[16966]: info: CoreStateMachine::syncState currentStatus play May 28 09:45:30 volumio volumio[16966]: info: Received an update from plugin. extracting info from payload May 28 09:45:30 volumio volumio[16966]: info: CoreStateMachine::pushState May 28 09:45:30 volumio volumio[16966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 09:45:30 volumio volumio[16966]: info: CoreCommandRouter::volumioPushState May 28 09:45:30 volumio volumio[16966]: info: MRS: Pushing multiroomSync output update for this device May 28 09:45:30 volumio volumio[16966]: info: MRS: Pushing multiroomSync output May 28 09:45:30 volumio volumio[16966]: info: CoreCommandRouter::volumioGetState May 28 09:45:30 volumio volumio[16966]: info: CoreStateMachine::pushState May 28 09:45:30 volumio volumio[16966]: info: CoreCommandRouter::volumioPushState May 28 09:45:30 volumio volumio[16966]: info: MRS: Pushing multiroomSync output update for this device May 28 09:45:30 volumio volumio[16966]: info: MRS: Pushing multiroomSync output May 28 09:45:30 volumio volumio[16966]: info: CoreCommandRouter::volumioGetState May 28 09:45:30 volumio volumio[16966]: info: ------------------------------ 23ms May 28 09:45:33 volumio volumio[16966]: info: Executing endpoint metavolumio May 28 09:45:33 volumio volumio[16966]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 28 09:45:34 volumio volumio[16966]: info: May 28 09:45:34 volumio volumio[16966]: ---------------------------- MPD announces system playlist update May 28 09:45:34 volumio volumio[16966]: info: Ignoring MPD Status Update May 28 09:45:34 volumio volumio[16966]: info: May 28 09:45:34 volumio volumio[16966]: ---------------------------- MPD announces state update: player May 28 09:45:34 volumio volumio[16966]: info: ControllerMpd::getState May 28 09:45:34 volumio volumio[16966]: verbose: ControllerMpd::sendMpdCommand status May 28 09:45:34 volumio volumio[16966]: info: ------------------------------ 2ms May 28 09:45:34 volumio volumio[16966]: info: sendMpdCommand status took 1 milliseconds May 28 09:45:34 volumio volumio[16966]: verbose: ControllerMpd::parseState May 28 09:45:34 volumio volumio[16966]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 09:45:34 volumio volumio[16966]: info: sendMpdCommand playlistinfo took 0 milliseconds May 28 09:45:34 volumio volumio[16966]: verbose: ControllerMpd::parseTrackInfo May 28 09:45:34 volumio volumio[16966]: info: ControllerMpd::pushState May 28 09:45:34 volumio volumio[16966]: info: CoreCommandRouter::servicePushState May 28 09:45:34 volumio volumio[16966]: info: CorePlayQueue::getTrack 0 May 28 09:45:34 volumio volumio[16966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":16375307,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Spik en Span - Es Vastelaovend Limburg Bênne Vêlt","artist":null,"album":null,"uri":"https://s20.reliastream.com:8010/stream","trackType":""} May 28 09:45:34 volumio volumio[16966]: verbose: CURRENT POSITION 0 May 28 09:45:34 volumio volumio[16966]: info: CoreStateMachine::syncState stateService play May 28 09:45:34 volumio volumio[16966]: info: CoreStateMachine::syncState currentStatus play May 28 09:45:34 volumio volumio[16966]: info: Received an update from plugin. extracting info from payload May 28 09:45:34 volumio volumio[16966]: info: CoreStateMachine::pushState May 28 09:45:34 volumio volumio[16966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 09:45:34 volumio volumio[16966]: info: CoreCommandRouter::volumioPushState May 28 09:45:34 volumio volumio[16966]: info: MRS: Pushing multiroomSync output update for this device May 28 09:45:34 volumio volumio[16966]: info: MRS: Pushing multiroomSync output May 28 09:45:34 volumio volumio[16966]: info: CoreCommandRouter::volumioGetState May 28 09:45:34 volumio volumio[16966]: info: CoreStateMachine::pushState May 28 09:45:34 volumio volumio[16966]: info: CoreCommandRouter::volumioPushState May 28 09:45:34 volumio volumio[16966]: info: MRS: Pushing multiroomSync output update for this device May 28 09:45:34 volumio volumio[16966]: info: MRS: Pushing multiroomSync output May 28 09:45:34 volumio volumio[16966]: info: CoreCommandRouter::volumioGetState May 28 09:45:34 volumio volumio[16966]: info: ------------------------------ 23ms May 28 09:45:37 volumio volumio[16966]: info: Executing endpoint metavolumio May 28 09:45:37 volumio volumio[16966]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 28 09:45:40 volumio nmbd[678]: [2026/05/28 09:45:40.287376, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 28 09:45:40 volumio nmbd[678]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.189 for name WORKGROUP<1d>. May 28 09:45:40 volumio nmbd[678]: This response was from IP 192.168.178.3, reporting an IP address of 192.168.178.3. May 28 09:45:40 volumio nmbd[678]: [2026/05/28 09:45:40.287708, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 28 09:45:40 volumio nmbd[678]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.242 for name WORKGROUP<1d>. May 28 09:45:40 volumio nmbd[678]: This response was from IP 192.168.178.3, reporting an IP address of 192.168.178.3. May 28 09:45:56 volumio volumio[16966]: info: May 28 09:45:56 volumio volumio[16966]: ---------------------------- MPD announces state update: player May 28 09:45:56 volumio volumio[16966]: info: ControllerMpd::getState May 28 09:45:56 volumio volumio[16966]: verbose: ControllerMpd::sendMpdCommand status May 28 09:45:56 volumio volumio[16966]: info: sendMpdCommand status took 1 milliseconds May 28 09:45:56 volumio volumio[16966]: verbose: ControllerMpd::parseState May 28 09:45:56 volumio volumio[16966]: info: ControllerMpd::pushState May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::servicePushState May 28 09:45:56 volumio volumio[16966]: info: CoreStateMachine::pushState May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::volumioPushState May 28 09:45:56 volumio volumio[16966]: info: MRS: Pushing multiroomSync output update for this device May 28 09:45:56 volumio volumio[16966]: info: MRS: Pushing multiroomSync output May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::volumioGetState May 28 09:45:56 volumio volumio[16966]: info: CorePlayQueue::getTrack 0 May 28 09:45:56 volumio volumio[16966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 28 09:45:56 volumio volumio[16966]: verbose: CURRENT POSITION 0 May 28 09:45:56 volumio volumio[16966]: info: CoreStateMachine::syncState stateService stop May 28 09:45:56 volumio volumio[16966]: info: CoreStateMachine::syncState currentStatus play May 28 09:45:56 volumio volumio[16966]: info: CoreStateMachine::play index undefined May 28 09:45:56 volumio volumio[16966]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 09:45:56 volumio volumio[16966]: info: CoreStateMachine::pushState May 28 09:45:56 volumio volumio[16966]: info: CorePlayQueue::getTrack 0 May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::volumioPushState May 28 09:45:56 volumio volumio[16966]: info: MRS: Pushing multiroomSync output update for this device May 28 09:45:56 volumio volumio[16966]: info: MRS: Pushing multiroomSync output May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::volumioGetState May 28 09:45:56 volumio volumio[16966]: info: CorePlayQueue::getTrack 0 May 28 09:45:56 volumio volumio[16966]: info: CorePlayQueue::getTrack 0 May 28 09:45:56 volumio volumio[16966]: info: CoreStateMachine::startPlaybackTimer May 28 09:45:56 volumio volumio[16966]: info: CorePlayQueue::getTrack 0 May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::volumioGetVisibleSources May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 28 09:45:56 volumio volumio[16966]: info: [1779954356842] ControllerWebradio::clearAddPlayTrack May 28 09:45:56 volumio volumio[16966]: verbose: ControllerMpd::sendMpdCommand stop May 28 09:45:56 volumio volumio[16966]: info: ------------------------------ 26ms May 28 09:45:56 volumio volumio[16966]: info: CoreStateMachine::pushState May 28 09:45:56 volumio volumio[16966]: info: CorePlayQueue::getTrack 0 May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::volumioPushState May 28 09:45:56 volumio volumio[16966]: info: MRS: Pushing multiroomSync output update for this device May 28 09:45:56 volumio volumio[16966]: info: MRS: Pushing multiroomSync output May 28 09:45:56 volumio volumio[16966]: info: CoreCommandRouter::volumioGetState May 28 09:45:56 volumio volumio[16966]: info: CorePlayQueue::getTrack 0 May 28 09:45:56 volumio volumio[16966]: info: sendMpdCommand stop took 10 milliseconds May 28 09:45:56 volumio volumio[16966]: verbose: ControllerMpd::sendMpdCommand clear May 28 09:45:56 volumio volumio[16966]: info: May 28 09:45:56 volumio volumio[16966]: ---------------------------- MPD announces system playlist update May 28 09:45:56 volumio volumio[16966]: info: Ignoring MPD Status Update May 28 09:45:56 volumio volumio[16966]: info: sendMpdCommand clear took 25 milliseconds May 28 09:45:56 volumio volumio[16966]: verbose: ControllerMpd::sendMpdCommand load "https://s20.reliastream.com:8010/stream" May 28 09:45:56 volumio volumio[16966]: error: updateQueue error: null May 28 09:45:56 volumio volumio[16966]: info: ------------------------------ 4ms May 28 09:45:59 volumio volumio[16966]: info: Executing endpoint metavolumio May 28 09:45:59 volumio volumio[16966]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 28 09:45:59 volumio volumio[16966]: info: MRS: STARTING volumioStreaming May 28 09:45:59 volumio sudo[12544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream16456.ts /tmp/hls/stream16457.ts /tmp/hls/stream16458.ts /tmp/hls/stream16459.ts /tmp/hls/stream16460.ts May 28 09:45:59 volumio sudo[12544]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 09:45:59 volumio sudo[12544]: pam_unix(sudo:session): session closed for user root May 28 09:45:59 volumio sudo[12547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming May 28 09:45:59 volumio sudo[12547]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 09:45:59 volumio systemd[1]: Stopping VolumioStreamingService... May 28 09:45:59 volumio systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM May 28 09:45:59 volumio volumio[16966]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 09:45:59 volumio systemd[1]: volumioStreaming.service: Succeeded. May 28 09:45:59 volumio systemd[1]: Stopped VolumioStreamingService. May 28 09:45:59 volumio volumio[16966]: TypeError: Cannot read property 'send' of null May 28 09:45:59 volumio volumio[16966]: at Client.send (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/client.js:128:11) May 28 09:45:59 volumio volumio[16966]: at Channel.send (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/channel.js:34:12) May 28 09:45:59 volumio volumio[16966]: at fn.Controller.send (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/controller.js:28:16) May 28 09:45:59 volumio volumio[16966]: at fn.RequestResponseController.request (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/request-response.js:34:8) May 28 09:45:59 volumio volumio[16966]: at fn.MediaController.sessionRequest (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/media.js:91:8) May 28 09:45:59 volumio volumio[16966]: at fn.MediaController.stop (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/media.js:107:8) May 28 09:45:59 volumio volumio[16966]: at DefaultMediaReceiver.stop (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/default-media-receiver.js:42:19) May 28 09:45:59 volumio volumio[16966]: at Timeout._onTimeout (/myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:5038) May 28 09:45:59 volumio volumio[16966]: at listOnTimeout (internal/timers.js:554:17) May 28 09:45:59 volumio volumio[16966]: at processTimers (internal/timers.js:497:7) May 28 09:45:59 volumio volumio[16966]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 09:46:00 volumio systemd[1]: Started VolumioStreamingService. May 28 09:46:00 volumio sudo[12547]: pam_unix(sudo:session): session closed for user root May 28 09:46:00 volumio sudo[12552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* May 28 09:46:00 volumio sudo[12552]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 09:46:00 volumio sudo[12552]: pam_unix(sudo:session): session closed for user root May 28 09:46:01 volumio sudo[12564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-05-28 09:45 May 28 09:46:01 volumio sudo[12564]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"