-- Logs begin at Wed 2026-08-26 23:26:18 CEST, end at Thu 2026-08-27 18:12:41 CEST. -- Aug 27 18:11:13 klnya autossh[26271]: starting ssh (count 11) Aug 27 18:11:13 klnya autossh[26271]: ssh child pid is 26674 Aug 27 18:11:13 klnya volumiossh-tunnel[26270]: Warning: Permanently added '[eu9.myvolumio.org]:2222,[164.92.213.40]:2222' (RSA) to the list of known hosts. Aug 27 18:11:20 klnya volumio[912]: info: Tunnel connection is inactive, restarting it Aug 27 18:11:20 klnya volumio[912]: info: Starting Tunnel 1 Aug 27 18:11:20 klnya volumio[912]: info: Starting Tunnel Connection Checker Aug 27 18:11:20 klnya sudo[26681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Aug 27 18:11:20 klnya sudo[26681]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 18:11:20 klnya autossh[26271]: received signal to exit (15) Aug 27 18:11:20 klnya systemd[1]: Stopping MyVolumio SSH Tunnel... Aug 27 18:11:20 klnya systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Aug 27 18:11:20 klnya systemd[1]: sshtunnel.service: Succeeded. Aug 27 18:11:20 klnya systemd[1]: Stopped MyVolumio SSH Tunnel. Aug 27 18:11:20 klnya volumio[912]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 27 18:11:20 klnya volumio[912]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 27 18:11:20 klnya systemd[1]: Started MyVolumio SSH Tunnel. Aug 27 18:11:20 klnya sudo[26681]: pam_unix(sudo:session): session closed for user root Aug 27 18:11:20 klnya autossh[26684]: port set to 0, monitoring disabled Aug 27 18:11:20 klnya autossh[26684]: starting ssh (count 1) Aug 27 18:11:20 klnya autossh[26684]: ssh child pid is 26687 Aug 27 18:11:20 klnya volumio[912]: info: Remote SSH Started Aug 27 18:11:20 klnya volumio[912]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Aug 27 18:11:20 klnya volumio[912]: info: CoreCommandRouter::volumioGetState Aug 27 18:11:20 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:11:20 klnya volumiossh-tunnel[26683]: Warning: Permanently added '[eu9.myvolumio.org]:2222,[164.92.213.40]:2222' (RSA) to the list of known hosts. Aug 27 18:12:23 klnya volumiossh-tunnel[26683]: Connection to eu9.myvolumio.org closed by remote host. Aug 27 18:12:23 klnya autossh[26684]: ssh exited with error status 255; restarting ssh Aug 27 18:12:23 klnya autossh[26684]: starting ssh (count 2) Aug 27 18:12:23 klnya autossh[26684]: ssh child pid is 26841 Aug 27 18:12:23 klnya volumiossh-tunnel[26683]: ssh: connect to host eu9.myvolumio.org port 2222: Connection refused Aug 27 18:12:23 klnya autossh[26684]: ssh exited with error status 255; restarting ssh Aug 27 18:12:23 klnya autossh[26684]: starting ssh (count 3) Aug 27 18:12:23 klnya autossh[26684]: ssh child pid is 26842 Aug 27 18:12:23 klnya volumiossh-tunnel[26683]: ssh: connect to host eu9.myvolumio.org port 2222: Connection refused Aug 27 18:12:23 klnya autossh[26684]: ssh exited with error status 255; restarting ssh Aug 27 18:12:23 klnya autossh[26684]: starting ssh (count 4) Aug 27 18:12:23 klnya autossh[26684]: ssh child pid is 26843 Aug 27 18:12:23 klnya volumiossh-tunnel[26683]: ssh: connect to host eu9.myvolumio.org port 2222: Connection refused Aug 27 18:12:23 klnya autossh[26684]: ssh exited with error status 255; restarting ssh Aug 27 18:12:23 klnya autossh[26684]: starting ssh (count 5) Aug 27 18:12:23 klnya autossh[26684]: ssh child pid is 26844 Aug 27 18:12:23 klnya volumiossh-tunnel[26683]: ssh: connect to host eu9.myvolumio.org port 2222: Connection refused Aug 27 18:12:23 klnya autossh[26684]: ssh exited with error status 255; restarting ssh Aug 27 18:12:23 klnya autossh[26684]: starting ssh (count 6) Aug 27 18:12:23 klnya autossh[26684]: ssh child pid is 26845 Aug 27 18:12:23 klnya volumiossh-tunnel[26683]: ssh: connect to host eu9.myvolumio.org port 2222: Connection refused Aug 27 18:12:23 klnya autossh[26684]: ssh exited with error status 255; restarting ssh Aug 27 18:12:23 klnya autossh[26684]: starting ssh (count 7) Aug 27 18:12:23 klnya autossh[26684]: ssh child pid is 26846 Aug 27 18:12:23 klnya volumiossh-tunnel[26683]: ssh: connect to host eu9.myvolumio.org port 2222: Connection refused Aug 27 18:12:23 klnya autossh[26684]: ssh exited with error status 255; restarting ssh Aug 27 18:12:25 klnya autossh[26684]: starting ssh (count 8) Aug 27 18:12:25 klnya autossh[26684]: ssh child pid is 26847 Aug 27 18:12:25 klnya volumiossh-tunnel[26683]: ssh: connect to host eu9.myvolumio.org port 2222: Connection refused Aug 27 18:12:25 klnya autossh[26684]: ssh exited with error status 255; restarting ssh Aug 27 18:12:33 klnya autossh[26684]: starting ssh (count 9) Aug 27 18:12:33 klnya autossh[26684]: ssh child pid is 26901 Aug 27 18:12:34 klnya volumiossh-tunnel[26683]: ssh: connect to host eu9.myvolumio.org port 2222: Connection refused Aug 27 18:12:34 klnya autossh[26684]: ssh exited with error status 255; restarting ssh Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Aug 27 18:12:39 klnya volumio[912]: info: Playing Remote Device: http://192.168.33.51 Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- Client requests Volumio play Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::volumioPlay Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::play index undefined Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::startPlaybackTimer Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/FreeJAZZ/alex-morgan-bebop-jazz-restaurant-552780.mp3 Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand stop Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand stop took 9 milliseconds Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand clear Aug 27 18:12:39 klnya volumio[912]: info: Done playing: Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- MPD announces system playlist update Aug 27 18:12:39 klnya volumio[912]: info: Ignoring MPD Status Update Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand clear took 6 milliseconds Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/FreeJAZZ/alex-morgan-bebop-jazz-restaurant-552780.mp3" Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- MPD announces system playlist update Aug 27 18:12:39 klnya volumio[912]: info: Ignoring MPD Status Update Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- MPD announces system playlist update Aug 27 18:12:39 klnya volumio[912]: info: Ignoring MPD Status Update Aug 27 18:12:39 klnya volumio[912]: error: updateQueue error: null Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- MPD announces system playlist update Aug 27 18:12:39 klnya volumio[912]: info: Ignoring MPD Status Update Aug 27 18:12:39 klnya volumio[912]: info: ------------------------------ 12ms Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand add "INTERNAL/FreeJAZZ/alex-morgan-bebop-jazz-restaurant-552780.mp3" took 10 milliseconds Aug 27 18:12:39 klnya volumio[912]: info: ------------------------------ 5ms Aug 27 18:12:39 klnya volumio[912]: info: ------------------------------ 3ms Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand play Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- MPD announces system playlist update Aug 27 18:12:39 klnya volumio[912]: info: Ignoring MPD Status Update Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- MPD announces system playlist update Aug 27 18:12:39 klnya volumio[912]: info: Ignoring MPD Status Update Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- MPD announces state update: player Aug 27 18:12:39 klnya volumio[912]: info: ------------------------------ 9ms Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand play took 7 milliseconds Aug 27 18:12:39 klnya volumio[912]: info: ControllerMpd::getState Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand status Aug 27 18:12:39 klnya volumio[912]: info: ------------------------------ 7ms Aug 27 18:12:39 klnya volumio[912]: info: ------------------------------ 5ms Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- MPD announces state update: player Aug 27 18:12:39 klnya volumio[912]: info: ControllerMpd::getState Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand status Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- MPD announces state update: player Aug 27 18:12:39 klnya volumio[912]: info: ControllerMpd::getState Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand status Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand status took 17 milliseconds Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::parseState Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- MPD announces state update: player Aug 27 18:12:39 klnya volumio[912]: info: ControllerMpd::getState Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand status Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand status took 18 milliseconds Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand status took 17 milliseconds Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::parseState Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::parseState Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::parseTrackInfo Aug 27 18:12:39 klnya volumio[912]: info: ControllerMpd::pushState Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::servicePushState Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:39 klnya volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":148,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"alex-morgan-bebop-jazz-restaurant-552780.mp3","artist":null,"album":null,"uri":"INTERNAL/FreeJAZZ/alex-morgan-bebop-jazz-restaurant-552780.mp3","trackType":"mp3"} Aug 27 18:12:39 klnya volumio[912]: verbose: CURRENT POSITION 0 Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::syncState stateService play Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::syncState currentStatus stop Aug 27 18:12:39 klnya volumio[912]: info: ------------------------------ 27ms Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- MPD announces state update: player Aug 27 18:12:39 klnya volumio[912]: info: ControllerMpd::getState Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand status Aug 27 18:12:39 klnya volumio[912]: info: Aug 27 18:12:39 klnya volumio[912]: ---------------------------- MPD announces state update: player Aug 27 18:12:39 klnya volumio[912]: info: ControllerMpd::getState Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand status Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand status took 10 milliseconds Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand playlistinfo took 8 milliseconds Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand status took 4 milliseconds Aug 27 18:12:39 klnya volumio[912]: info: sendMpdCommand status took 3 milliseconds Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::parseState Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::parseTrackInfo Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::parseTrackInfo Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::parseState Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::parseState Aug 27 18:12:39 klnya volumio[912]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 27 18:12:39 klnya volumio[912]: info: ControllerMpd::pushState Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::servicePushState Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:39 klnya volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1207,"duration":148,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"alex-morgan-bebop-jazz-restaurant-552780.mp3","artist":null,"album":null,"uri":"INTERNAL/FreeJAZZ/alex-morgan-bebop-jazz-restaurant-552780.mp3","trackType":"mp3"} Aug 27 18:12:39 klnya volumio[912]: verbose: CURRENT POSITION 0 Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::syncState stateService play Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::syncState currentStatus play Aug 27 18:12:39 klnya volumio[912]: info: Received an update from plugin. extracting info from payload Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::pushState Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::volumioPushState Aug 27 18:12:39 klnya volumio[912]: info: MRS: Pushing multiroomSync output update for this device Aug 27 18:12:39 klnya volumio[912]: info: MRS: Pushing multiroomSync output Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::volumioGetState Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::pushState Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::volumioPushState Aug 27 18:12:39 klnya volumio[912]: info: MRS: Pushing multiroomSync output update for this device Aug 27 18:12:39 klnya volumio[912]: info: MRS: Pushing multiroomSync output Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::volumioGetState Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:39 klnya volumio[912]: info: ControllerMpd::pushState Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::servicePushState Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:39 klnya volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1238,"duration":148,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"alex-morgan-bebop-jazz-restaurant-552780.mp3","artist":null,"album":null,"uri":"INTERNAL/FreeJAZZ/alex-morgan-bebop-jazz-restaurant-552780.mp3","trackType":"mp3"} Aug 27 18:12:39 klnya volumio[912]: verbose: CURRENT POSITION 0 Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::syncState stateService play Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::syncState currentStatus play Aug 27 18:12:39 klnya volumio[912]: info: Received an update from plugin. extracting info from payload Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::pushState Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::volumioPushState Aug 27 18:12:39 klnya volumio[912]: info: MRS: Pushing multiroomSync output update for this device Aug 27 18:12:39 klnya volumio[912]: info: MRS: Pushing multiroomSync output Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::volumioGetState Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:39 klnya volumio[912]: info: CoreStateMachine::pushState Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::volumioPushState Aug 27 18:12:39 klnya volumio[912]: info: MRS: Pushing multiroomSync output update for this device Aug 27 18:12:39 klnya volumio[912]: info: MRS: Pushing multiroomSync output Aug 27 18:12:39 klnya volumio[912]: info: CoreCommandRouter::volumioGetState Aug 27 18:12:39 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: ------------------------------ 73ms Aug 27 18:12:40 klnya volumio[912]: info: ------------------------------ 72ms Aug 27 18:12:40 klnya volumio[912]: info: sendMpdCommand playlistinfo took 45 milliseconds Aug 27 18:12:40 klnya volumio[912]: info: sendMpdCommand playlistinfo took 45 milliseconds Aug 27 18:12:40 klnya volumio[912]: info: sendMpdCommand playlistinfo took 45 milliseconds Aug 27 18:12:40 klnya volumio[912]: verbose: ControllerMpd::parseTrackInfo Aug 27 18:12:40 klnya volumio[912]: verbose: ControllerMpd::parseTrackInfo Aug 27 18:12:40 klnya volumio[912]: verbose: ControllerMpd::parseTrackInfo Aug 27 18:12:40 klnya volumio[912]: info: ControllerMpd::pushState Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::servicePushState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1238,"duration":148,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"alex-morgan-bebop-jazz-restaurant-552780.mp3","artist":null,"album":null,"uri":"INTERNAL/FreeJAZZ/alex-morgan-bebop-jazz-restaurant-552780.mp3","trackType":"mp3"} Aug 27 18:12:40 klnya volumio[912]: verbose: CURRENT POSITION 0 Aug 27 18:12:40 klnya volumio[912]: info: CoreStateMachine::syncState stateService play Aug 27 18:12:40 klnya volumio[912]: info: CoreStateMachine::syncState currentStatus play Aug 27 18:12:40 klnya volumio[912]: info: Received an update from plugin. extracting info from payload Aug 27 18:12:40 klnya volumio[912]: info: CoreStateMachine::pushState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::volumioPushState Aug 27 18:12:40 klnya volumio[912]: info: MRS: Pushing multiroomSync output update for this device Aug 27 18:12:40 klnya volumio[912]: info: MRS: Pushing multiroomSync output Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::volumioGetState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: CoreStateMachine::pushState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::volumioPushState Aug 27 18:12:40 klnya volumio[912]: info: MRS: Pushing multiroomSync output update for this device Aug 27 18:12:40 klnya volumio[912]: info: MRS: Pushing multiroomSync output Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::volumioGetState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: ControllerMpd::pushState Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::servicePushState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1238,"duration":148,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"alex-morgan-bebop-jazz-restaurant-552780.mp3","artist":null,"album":null,"uri":"INTERNAL/FreeJAZZ/alex-morgan-bebop-jazz-restaurant-552780.mp3","trackType":"mp3"} Aug 27 18:12:40 klnya volumio[912]: verbose: CURRENT POSITION 0 Aug 27 18:12:40 klnya volumio[912]: info: CoreStateMachine::syncState stateService play Aug 27 18:12:40 klnya volumio[912]: info: CoreStateMachine::syncState currentStatus play Aug 27 18:12:40 klnya volumio[912]: info: Received an update from plugin. extracting info from payload Aug 27 18:12:40 klnya volumio[912]: info: CoreStateMachine::pushState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::volumioPushState Aug 27 18:12:40 klnya volumio[912]: info: MRS: Pushing multiroomSync output update for this device Aug 27 18:12:40 klnya volumio[912]: info: MRS: Pushing multiroomSync output Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::volumioGetState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: CoreStateMachine::pushState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::volumioPushState Aug 27 18:12:40 klnya volumio[912]: info: MRS: Pushing multiroomSync output update for this device Aug 27 18:12:40 klnya volumio[912]: info: MRS: Pushing multiroomSync output Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::volumioGetState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: ControllerMpd::pushState Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::servicePushState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1238,"duration":148,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"alex-morgan-bebop-jazz-restaurant-552780.mp3","artist":null,"album":null,"uri":"INTERNAL/FreeJAZZ/alex-morgan-bebop-jazz-restaurant-552780.mp3","trackType":"mp3"} Aug 27 18:12:40 klnya volumio[912]: verbose: CURRENT POSITION 0 Aug 27 18:12:40 klnya volumio[912]: info: CoreStateMachine::syncState stateService play Aug 27 18:12:40 klnya volumio[912]: info: CoreStateMachine::syncState currentStatus play Aug 27 18:12:40 klnya volumio[912]: info: Received an update from plugin. extracting info from payload Aug 27 18:12:40 klnya volumio[912]: info: CoreStateMachine::pushState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::volumioPushState Aug 27 18:12:40 klnya volumio[912]: info: MRS: Pushing multiroomSync output update for this device Aug 27 18:12:40 klnya volumio[912]: info: MRS: Pushing multiroomSync output Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::volumioGetState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: CoreStateMachine::pushState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::volumioPushState Aug 27 18:12:40 klnya volumio[912]: info: MRS: Pushing multiroomSync output update for this device Aug 27 18:12:40 klnya volumio[912]: info: MRS: Pushing multiroomSync output Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::volumioGetState Aug 27 18:12:40 klnya volumio[912]: info: CorePlayQueue::getTrack 0 Aug 27 18:12:40 klnya volumio[912]: info: ------------------------------ 107ms Aug 27 18:12:40 klnya volumio[912]: info: ------------------------------ 101ms Aug 27 18:12:40 klnya volumio[912]: info: ------------------------------ 101ms Aug 27 18:12:40 klnya volumio[912]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Aug 27 18:12:40 klnya volumio[912]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Aug 27 18:12:40 klnya volumio[912]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 18:12:40 klnya volumio[912]: TypeError: Cannot read property 'then' of undefined Aug 27 18:12:40 klnya volumio[912]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Aug 27 18:12:40 klnya volumio[912]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30) Aug 27 18:12:40 klnya volumio[912]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1456:26) Aug 27 18:12:40 klnya volumio[912]: at Socket.emit (events.js:315:20) Aug 27 18:12:40 klnya volumio[912]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 27 18:12:40 klnya volumio[912]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 27 18:12:40 klnya volumio[912]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 18:12:41 klnya sudo[26929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-27 18:11 Aug 27 18:12:41 klnya sudo[26929]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"