Feb 18 14:42:03 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioGetState
Feb 18 14:42:03 bedroom-demarco volumio[1139]: info: Listing playlists
Feb 18 14:42:03 bedroom-demarco volumio[1139]: info: Listing playlists
Feb 18 14:42:13 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioGetState
Feb 18 14:42:22 bedroom-demarco volumio5-onboarding[1380]: time=2026-02-18T14:42:22.382Z level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.35:34252
Feb 18 14:42:22 bedroom-demarco volumio5-onboarding[1380]: time=2026-02-18T14:42:22.382Z level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.35:34252
Feb 18 14:42:22 bedroom-demarco volumio5-onboarding[1380]: time=2026-02-18T14:42:22.403Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.35:43294
Feb 18 14:42:23 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioGetState
Feb 18 14:42:23 bedroom-demarco volumio[1139]: info: Listing playlists
Feb 18 14:42:23 bedroom-demarco volumio[1139]: info: Listing playlists
Feb 18 14:42:33 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioGetState
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info:
Feb 18 14:42:36 bedroom-demarco volumio[1139]: ---------------------------- MPD announces system playlist update
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: Ignoring MPD Status Update
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info:
Feb 18 14:42:36 bedroom-demarco volumio[1139]: ---------------------------- MPD announces state update: player
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: ControllerMpd::getState
Feb 18 14:42:36 bedroom-demarco volumio[1139]: verbose: ControllerMpd::sendMpdCommand status
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: ------------------------------ 3ms
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: sendMpdCommand status took 3 milliseconds
Feb 18 14:42:36 bedroom-demarco volumio[1139]: verbose: ControllerMpd::parseState
Feb 18 14:42:36 bedroom-demarco volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 18 14:42:36 bedroom-demarco volumio[1139]: verbose: ControllerMpd::parseTrackInfo
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: ControllerMpd::pushState
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: CoreCommandRouter::servicePushState
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: CorePlayQueue::getTrack 0
Feb 18 14:42:36 bedroom-demarco volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":71603,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ClassicFMMP3","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Feb 18 14:42:36 bedroom-demarco volumio[1139]: verbose: CURRENT POSITION 0
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: CoreStateMachine::syncState stateService play
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: CoreStateMachine::syncState currentStatus play
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: Received an update from plugin. extracting info from payload
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: CoreStateMachine::pushState
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: CorePlayQueue::getTrack 0
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioPushState
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: MRS: Pushing multiroomSync output update for this device
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: MRS: Pushing multiroomSync output
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioGetState
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: CoreStateMachine::pushState
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioPushState
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: MRS: Pushing multiroomSync output update for this device
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: MRS: Pushing multiroomSync output
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioGetState
Feb 18 14:42:36 bedroom-demarco volumio5-onboarding[1380]: time=2026-02-18T14:42:36.777Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.35:43294 @ 0x1d4c960" state=STATUS_PLAYING positionMs=70116 volume=100
Feb 18 14:42:36 bedroom-demarco volumio5-onboarding[1380]: time=2026-02-18T14:42:36.778Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.35:43294 @ 0x1d4c960" id=http://media-ice.musicradio.com/ClassicFMMP3 title="Classic FM"
Feb 18 14:42:36 bedroom-demarco volumio5-onboarding[1380]: time=2026-02-18T14:42:36.780Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.35:43294 @ 0x1d4c960" state=STATUS_PLAYING positionMs=70116 volume=100
Feb 18 14:42:36 bedroom-demarco volumio5-onboarding[1380]: time=2026-02-18T14:42:36.781Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.35:43294 @ 0x1d4c960" id=http://media-ice.musicradio.com/ClassicFMMP3 title="Classic FM"
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: ------------------------------ 33ms
Feb 18 14:42:36 bedroom-demarco volumio[1139]: info: MRS: Updating multiroomSync output
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info:
Feb 18 14:42:38 bedroom-demarco volumio[1139]: ---------------------------- MPD announces system playlist update
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: Ignoring MPD Status Update
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info:
Feb 18 14:42:38 bedroom-demarco volumio[1139]: ---------------------------- MPD announces state update: player
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: ControllerMpd::getState
Feb 18 14:42:38 bedroom-demarco volumio[1139]: verbose: ControllerMpd::sendMpdCommand status
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: ------------------------------ 3ms
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: sendMpdCommand status took 1 milliseconds
Feb 18 14:42:38 bedroom-demarco volumio[1139]: verbose: ControllerMpd::parseState
Feb 18 14:42:38 bedroom-demarco volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 18 14:42:38 bedroom-demarco volumio[1139]: verbose: ControllerMpd::parseTrackInfo
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: ControllerMpd::pushState
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: CoreCommandRouter::servicePushState
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: CorePlayQueue::getTrack 0
Feb 18 14:42:38 bedroom-demarco volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":73471,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Paul Simon, Milos Karadaglic - The Sound Of Silence","artist":"Classic FM","album":null,"uri":"http://media-ice.musicradio.com/ClassicFMMP3","trackType":""}
Feb 18 14:42:38 bedroom-demarco volumio[1139]: verbose: CURRENT POSITION 0
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: CoreStateMachine::syncState stateService play
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: CoreStateMachine::syncState currentStatus play
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: Received an update from plugin. extracting info from payload
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: CoreStateMachine::pushState
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioPushState
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: MRS: Pushing multiroomSync output update for this device
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: MRS: Pushing multiroomSync output
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioGetState
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: CoreStateMachine::pushState
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioPushState
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: MRS: Pushing multiroomSync output update for this device
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: MRS: Pushing multiroomSync output
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioGetState
Feb 18 14:42:38 bedroom-demarco volumio5-onboarding[1380]: time=2026-02-18T14:42:38.617Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.35:43294 @ 0x1d4c960" state=STATUS_PLAYING positionMs=71867 volume=100
Feb 18 14:42:38 bedroom-demarco volumio5-onboarding[1380]: time=2026-02-18T14:42:38.618Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.35:43294 @ 0x1d4c960" id=http://media-ice.musicradio.com/ClassicFMMP3 title="Paul Simon, Milos Karadaglic - The Sound Of Silence"
Feb 18 14:42:38 bedroom-demarco volumio5-onboarding[1380]: time=2026-02-18T14:42:38.618Z level=INFO msg="emitting player state changed event" component=server peer="192.168.1.35:43294 @ 0x1d4c960" state=STATUS_PLAYING positionMs=71867 volume=100
Feb 18 14:42:38 bedroom-demarco volumio5-onboarding[1380]: time=2026-02-18T14:42:38.619Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.35:43294 @ 0x1d4c960" id=http://media-ice.musicradio.com/ClassicFMMP3 title="Paul Simon, Milos Karadaglic - The Sound Of Silence"
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: ------------------------------ 24ms
Feb 18 14:42:38 bedroom-demarco volumio[1139]: info: MRS: Updating multiroomSync output
Feb 18 14:42:43 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioGetState
Feb 18 14:42:43 bedroom-demarco volumio[1139]: info: Listing playlists
Feb 18 14:42:43 bedroom-demarco volumio[1139]: info: Listing playlists
Feb 18 14:42:48 bedroom-demarco volumio[1139]: info: MRS: Updating multiroomSync output
Feb 18 14:42:48 bedroom-demarco volumio[1139]: info: MRS: Updating multiroomSync output
Feb 18 14:42:48 bedroom-demarco volumio[1139]: info: MRS: Updating multiroomSync output
Feb 18 14:42:48 bedroom-demarco volumio[1139]: info: MRS: Updating multiroomSync output
Feb 18 14:42:49 bedroom-demarco bluealsa[978]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_58_24_29_E2_5C_62/avrcp/player0/NowPlaying/item1, ...)
Feb 18 14:42:49 bedroom-demarco volumio[1139]: ------------------------------------ BT MESSAGE: Received new metadata for 58:24:29:E2:5C:62
Feb 18 14:42:49 bedroom-demarco volumio[1139]: ------------------------------------ BT MESSAGE: [metaCache] Saved metadata to /tmp/bluetooth-cache/meta-58:24:29:E2:5C:62.json
Feb 18 14:42:49 bedroom-demarco volumio[1139]: info: CoreCommandRouter::servicePushState
Feb 18 14:42:49 bedroom-demarco volumio[1139]: info: CorePlayQueue::getTrack 0
Feb 18 14:42:49 bedroom-demarco volumio[1139]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received bluetooth
Feb 18 14:42:50 bedroom-demarco snapserver[8696]: Error reading message header of length 0: End of file
Feb 18 14:42:50 bedroom-demarco snapserver[8696]: onDisconnect: b8:27:eb:85:c8:8a
Feb 18 14:42:53 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioGetState
Feb 18 14:43:03 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioGetState
Feb 18 14:43:03 bedroom-demarco volumio[1139]: info: Listing playlists
Feb 18 14:43:03 bedroom-demarco volumio[1139]: info: Listing playlists
Feb 18 14:43:04 bedroom-demarco volumio[1139]: info: MRS: Updating multiroomSync output
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: CoreCommandRouter::volumioGetState
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Removing multiroom client: 39ada9d8-2ac1-489c-8307-bf0083c17351
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Removing another device as multiroomSync client
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Check for remaining clients: 0
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput
Feb 18 14:43:13 bedroom-demarco volumio[1139]: error: MRS: impossible to disable 39ada9d8-2ac1-489c-8307-bf0083c17351: device not found
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Starting browser stream
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Pushing multiroomSync output
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Setting this device as Streaming Server
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info:
Feb 18 14:43:13 bedroom-demarco volumio[1139]: [1771425793872] ---------------------------- MRS: Setting Streaming Server
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Starting browser stream
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Setting this device as Streaming Server
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info:
Feb 18 14:43:13 bedroom-demarco volumio[1139]: [1771425793875] ---------------------------- MRS: Setting Streaming Server
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Setting this device as single
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info:
Feb 18 14:43:13 bedroom-demarco volumio[1139]: [1771425793888] ---------------------------- Setting Multiroom Single
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Starting cast device: Google-Nest-Mini-16aae7e41b8a6f186fa3b7bc11989331
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Starting cast device: Google-Nest-Mini-76e7d5ffb8c44a5fbd956ac7970eeecf
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Starting cast device: Google-Nest-Mini-16aae7e41b8a6f186fa3b7bc11989331
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: STOPPING SNAPCLIENT
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: Enabled audio output: browserPlayback
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: Enabled audio output: browserPlayback
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: disable multiroom output
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Set multiroom target PCM to volumioDiscard
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Pushing multiroomSync output
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: Enabled audio output: Google-Nest-Mini-16aae7e41b8a6f186fa3b7bc11989331
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: Enabled audio output: Google-Nest-Mini-76e7d5ffb8c44a5fbd956ac7970eeecf
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: Enabled audio output: Google-Nest-Mini-16aae7e41b8a6f186fa3b7bc11989331
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Snap server stop
Feb 18 14:43:13 bedroom-demarco sudo[9156]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Feb 18 14:43:13 bedroom-demarco sudo[9156]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: enable multiroom server output
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Set multiroom target PCM to volumioMultiRoom
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: enable multiroom server output
Feb 18 14:43:13 bedroom-demarco snapclient[8689]: 2026-02-18 14-43-13.980 [Info] (Snapclient) Received signal 15: Terminated
Feb 18 14:43:13 bedroom-demarco volumio[1139]: info: MRS: Set multiroom target PCM to volumioMultiRoom
Feb 18 14:43:13 bedroom-demarco snapserver[8696]: Error reading message header of length 0: End of file
Feb 18 14:43:13 bedroom-demarco snapclient[8689]: 2026-02-18 14-43-13.986 [Notice] (Snapclient) Snapclient terminated.
Feb 18 14:43:13 bedroom-demarco systemd[1]: Stopping volumioSnapclient.service - Snapcast client...
Feb 18 14:43:13 bedroom-demarco snapserver[8696]: onDisconnect: b8:27:eb:ba:8d:45
Feb 18 14:43:13 bedroom-demarco systemd[1]: volumioSnapclient.service: Deactivated successfully.
Feb 18 14:43:13 bedroom-demarco systemd[1]: Stopped volumioSnapclient.service - Snapcast client.
Feb 18 14:43:14 bedroom-demarco systemd[1]: volumioSnapclient.service: Consumed 3.062s CPU time.
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Setting this device as Streaming Server
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info:
Feb 18 14:43:14 bedroom-demarco volumio[1139]: [1771425794008] ---------------------------- MRS: Setting Streaming Server
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Setting this device as Streaming Server
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info:
Feb 18 14:43:14 bedroom-demarco volumio[1139]: [1771425794009] ---------------------------- MRS: Setting Streaming Server
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Setting this device as Streaming Server
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info:
Feb 18 14:43:14 bedroom-demarco volumio[1139]: [1771425794009] ---------------------------- MRS: Setting Streaming Server
Feb 18 14:43:14 bedroom-demarco sudo[9160]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Feb 18 14:43:14 bedroom-demarco sudo[9160]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco sudo[9156]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: enable multiroom server output
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Set multiroom target PCM to volumioMultiRoom
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: enable multiroom server output
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Set multiroom target PCM to volumioMultiRoom
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: enable multiroom server output
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Set multiroom target PCM to volumioMultiRoom
Feb 18 14:43:14 bedroom-demarco snapserver[8696]: Received signal 15: Terminated
Feb 18 14:43:14 bedroom-demarco snapserver[8696]: Stopping streamServer
Feb 18 14:43:14 bedroom-demarco systemd[1]: Stopping volumioSnapserver.service - Snapcast server...
Feb 18 14:43:14 bedroom-demarco snapserver[8696]: done
Feb 18 14:43:14 bedroom-demarco snapserver[8696]: Snapserver terminated.
Feb 18 14:43:14 bedroom-demarco systemd[1]: volumioSnapserver.service: Deactivated successfully.
Feb 18 14:43:14 bedroom-demarco systemd[1]: Stopped volumioSnapserver.service - Snapcast server.
Feb 18 14:43:14 bedroom-demarco systemd[1]: volumioSnapserver.service: Consumed 4.409s CPU time.
Feb 18 14:43:14 bedroom-demarco sudo[9160]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Updating multiroomSync output
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: SNAPSERVER STOPPED
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioDiscard
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: SNAPCLIENT STOPPED
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Set multiroom target PCM to volumioLocalPlayback
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Set multiroom target PCM to volumioLocalPlayback
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Set multiroom target PCM to volumioLocalPlayback
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Set multiroom target PCM to volumioLocalPlayback
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Set multiroom target PCM to volumioLocalPlayback
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: STARTING volumioStreaming
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: STARTING volumioStreaming
Feb 18 14:43:14 bedroom-demarco sudo[9174]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Feb 18 14:43:14 bedroom-demarco sudo[9174]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco sudo[9174]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco sudo[9176]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming
Feb 18 14:43:14 bedroom-demarco sudo[9176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco sudo[9179]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Feb 18 14:43:14 bedroom-demarco sudo[9179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: STARTING volumioStreaming
Feb 18 14:43:14 bedroom-demarco sudo[9179]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco sudo[9182]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming
Feb 18 14:43:14 bedroom-demarco sudo[9182]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: STARTING volumioStreaming
Feb 18 14:43:14 bedroom-demarco sudo[9185]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Feb 18 14:43:14 bedroom-demarco sudo[9185]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco sudo[9185]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco sudo[9191]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Feb 18 14:43:14 bedroom-demarco sudo[9191]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco sudo[9190]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming
Feb 18 14:43:14 bedroom-demarco sudo[9190]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco sudo[9191]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco sudo[9196]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming
Feb 18 14:43:14 bedroom-demarco sudo[9196]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: STARTING volumioStreaming
Feb 18 14:43:14 bedroom-demarco sudo[9176]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco sudo[9199]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Feb 18 14:43:14 bedroom-demarco sudo[9199]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco sudo[9199]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco sudo[9202]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Feb 18 14:43:14 bedroom-demarco sudo[9202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco sudo[9202]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco systemd[1]: Stopping volumioStreaming.service - VolumioStreamingService...
Feb 18 14:43:14 bedroom-demarco systemd[1]: volumioStreaming.service: Killing process 9206 (ffmpeg) with signal SIGKILL.
Feb 18 14:43:14 bedroom-demarco systemd[1]: volumioStreaming.service: Deactivated successfully.
Feb 18 14:43:14 bedroom-demarco systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
Feb 18 14:43:14 bedroom-demarco volumio[1139]: info: MRS: Connected to cast device: Google-Nest-Mini-76e7d5ffb8c44a5fbd956ac7970eeecf
Feb 18 14:43:14 bedroom-demarco sudo[9205]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming
Feb 18 14:43:14 bedroom-demarco sudo[9205]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 18 14:43:14 bedroom-demarco volumio[1139]: TypeError: Cannot read properties of null (reading 'launch')
Feb 18 14:43:14 bedroom-demarco volumio[1139]: at PlatformSender.launch (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/platform.js:94:17)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: at /myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:29901
Feb 18 14:43:14 bedroom-demarco volumio[1139]: at Client. (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/platform.js:61:5)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: at Object.onceWrapper (node:events:628:28)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: at Client.emit (node:events:514:28)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: at TLSSocket. (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/client.js:40:10)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: at Object.onceWrapper (node:events:628:28)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: at TLSSocket.emit (node:events:514:28)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: at TLSSocket.onConnectSecure (node:_tls_wrap:1660:10)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: at TLSSocket.emit (node:events:514:28)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: at TLSSocket._finishInit (node:_tls_wrap:1038:8)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: at ssl.onhandshakedone (node:_tls_wrap:824:12)
Feb 18 14:43:14 bedroom-demarco volumio[1139]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 18 14:43:14 bedroom-demarco systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
Feb 18 14:43:14 bedroom-demarco sudo[9190]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco sudo[9182]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco sudo[9196]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco sudo[9213]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Feb 18 14:43:14 bedroom-demarco sudo[9213]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco sudo[9213]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco systemd[1]: Stopping volumioStreaming.service - VolumioStreamingService...
Feb 18 14:43:14 bedroom-demarco systemd[1]: volumioStreaming.service: Killing process 9223 (ffmpeg) with signal SIGKILL.
Feb 18 14:43:14 bedroom-demarco systemd[1]: volumioStreaming.service: Deactivated successfully.
Feb 18 14:43:14 bedroom-demarco systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
Feb 18 14:43:14 bedroom-demarco systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
Feb 18 14:43:14 bedroom-demarco sudo[9205]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:14 bedroom-demarco sudo[9225]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Feb 18 14:43:14 bedroom-demarco sudo[9225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 14:43:14 bedroom-demarco sudo[9225]: pam_unix(sudo:session): session closed for user root
Feb 18 14:43:15 bedroom-demarco sudo[9231]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-18 14:42'
Feb 18 14:43:15 bedroom-demarco sudo[9231]: 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"