-- Logs begin at Thu 2019-02-14 10:11:58 GMT, end at Sun 2025-05-25 18:38:04 BST. -- May 25 18:37:57 myvolumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput May 25 18:37:57 myvolumio volumio[835]: info: MRS: Setting this device as single May 25 18:37:57 myvolumio volumio[835]: info: May 25 18:37:57 myvolumio volumio[835]: [1748194677927] ---------------------------- Setting Multiroom Single May 25 18:37:57 myvolumio volumio[835]: info: MRS: disable multiroom output May 25 18:37:57 myvolumio volumio[835]: info: MRS: Set multiroom target PCM to volumioDiscard May 25 18:37:57 myvolumio volumio[835]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioDiscard May 25 18:37:58 myvolumio volumio[835]: info: MRS: Set multiroom target PCM to volumioLocalPlayback May 25 18:37:58 myvolumio volumio[835]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioLocalPlayback May 25 18:37:59 myvolumio volumio[835]: info: MRS: STOPPING volumioStreaming May 25 18:37:59 myvolumio sudo[29563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming May 25 18:37:59 myvolumio sudo[29563]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:37:59 myvolumio systemd[1]: Stopping VolumioStreamingService... May 25 18:37:59 myvolumio systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM May 25 18:37:59 myvolumio sudo[29566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* May 25 18:37:59 myvolumio sudo[29566]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 18:37:59 myvolumio sudo[29566]: pam_unix(sudo:session): session closed for user root May 25 18:37:59 myvolumio systemd[1]: volumioStreaming.service: Succeeded. May 25 18:37:59 myvolumio systemd[1]: Stopped VolumioStreamingService. May 25 18:37:59 myvolumio volumio[835]: info: MRS: Removed streaming files May 25 18:37:59 myvolumio sudo[29563]: pam_unix(sudo:session): session closed for user root May 25 18:37:59 myvolumio volumio[835]: info: MRS: volumioStreaming STOPPED May 25 18:38:01 myvolumio volumio[835]: info: CoreCommandRouter::volumioGetState May 25 18:38:01 myvolumio volumio[835]: info: CorePlayQueue::getTrack 78 May 25 18:38:02 myvolumio volumio[835]: info: CoreCommandRouter::volumioPlay May 25 18:38:02 myvolumio volumio[835]: info: CoreStateMachine::play index undefined May 25 18:38:02 myvolumio volumio[835]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 18:38:02 myvolumio volumio[835]: info: CorePlayQueue::getTrack 78 May 25 18:38:02 myvolumio volumio[835]: info: CoreStateMachine::startPlaybackTimer May 25 18:38:02 myvolumio volumio[835]: info: CorePlayQueue::getTrack 78 May 25 18:38:02 myvolumio volumio[835]: info: ControllerMpd::resume May 25 18:38:02 myvolumio volumio[835]: verbose: ControllerMpd::sendMpdCommand play May 25 18:38:02 myvolumio volumio[835]: info: sendMpdCommand play took 5 milliseconds May 25 18:38:02 myvolumio volumio[835]: info: May 25 18:38:02 myvolumio volumio[835]: ---------------------------- MPD announces state update: player May 25 18:38:02 myvolumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! May 25 18:38:02 myvolumio volumio[835]: info: ControllerMpd::getState May 25 18:38:02 myvolumio volumio[835]: verbose: ControllerMpd::sendMpdCommand status May 25 18:38:02 myvolumio volumio[835]: info: sendMpdCommand status took 2 milliseconds May 25 18:38:02 myvolumio volumio[835]: verbose: ControllerMpd::parseState May 25 18:38:02 myvolumio volumio[835]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 18:38:02 myvolumio volumio[835]: info: sendMpdCommand playlistinfo took 1 milliseconds May 25 18:38:02 myvolumio volumio[835]: verbose: ControllerMpd::parseTrackInfo May 25 18:38:02 myvolumio volumio[835]: info: ControllerMpd::pushState May 25 18:38:02 myvolumio volumio[835]: info: CoreCommandRouter::servicePushState May 25 18:38:02 myvolumio volumio[835]: info: CorePlayQueue::getTrack 78 May 25 18:38:02 myvolumio volumio[835]: verbose: STATE SERVICE {"status":"play","position":0,"seek":116641,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"893 Kbps","isStreaming":false,"title":"Pop Pop Pop","artist":"Idles","album":"TANGK","uri":"NAS/Music/Idles/TANGK/03_Pop Pop Pop.flac","trackType":"flac"} May 25 18:38:02 myvolumio volumio[835]: verbose: CURRENT POSITION 78 May 25 18:38:02 myvolumio volumio[835]: info: CoreStateMachine::syncState stateService play May 25 18:38:02 myvolumio volumio[835]: info: CoreStateMachine::syncState currentStatus pause May 25 18:38:02 myvolumio volumio[835]: info: CoreStateMachine::pushState May 25 18:38:02 myvolumio volumio[835]: info: CorePlayQueue::getTrack 78 May 25 18:38:02 myvolumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 18:38:02 myvolumio volumio[835]: info: CoreCommandRouter::volumioPushState May 25 18:38:02 myvolumio volumio[835]: info: MRS: Pushing multiroomSync output update for this device May 25 18:38:02 myvolumio volumio[835]: info: MRS: Pushing multiroomSync output May 25 18:38:02 myvolumio volumio[835]: info: CoreCommandRouter::volumioGetState May 25 18:38:02 myvolumio volumio[835]: info: CorePlayQueue::getTrack 78 May 25 18:38:02 myvolumio volumio[835]: info: ------------------------------ 21ms May 25 18:38:03 myvolumio volumio[835]: info: Executing endpoint metavolumio May 25 18:38:03 myvolumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 25 18:38:03 myvolumio volumio[835]: info: Executing endpoint metavolumio May 25 18:38:03 myvolumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 25 18:38:03 myvolumio volumio[835]: info: Executing endpoint metavolumio May 25 18:38:03 myvolumio volumio[835]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 25 18:38:04 myvolumio volumio[835]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 18:38:04 myvolumio volumio[835]: TypeError: Cannot read property 'deviceDescription' of null May 25 18:38:04 myvolumio volumio[835]: at multiroom.startSonosDevice (/myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:30637) May 25 18:38:04 myvolumio volumio[835]: at Timeout._onTimeout (/myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:4747) May 25 18:38:04 myvolumio volumio[835]: at listOnTimeout (internal/timers.js:554:17) May 25 18:38:04 myvolumio volumio[835]: at processTimers (internal/timers.js:497:7) May 25 18:38:04 myvolumio volumio[835]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 18:38:04 myvolumio sudo[29599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-25 18:37 May 25 18:38:04 myvolumio sudo[29599]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"